Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2338/
Java: 32bit/jdk-9-ea+140 -server -XX:+UseG1GC

2 tests failed.
FAILED:  
org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields

Error Message:
No live SolrServers available to handle this 
request:[http://127.0.0.1:35261/solr/managed-preanalyzed, 
http://127.0.0.1:43033/solr/managed-preanalyzed]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[http://127.0.0.1:35261/solr/managed-preanalyzed, 
http://127.0.0.1:43033/solr/managed-preanalyzed]
        at 
__randomizedtesting.SeedInfo.seed([82FBEFF3B881DE8E:2AEE5D1864874D78]:0)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:414)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1344)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1095)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1037)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
        at 
org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.addField(PreAnalyzedFieldManagedSchemaCloudTest.java:61)
        at 
org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields(PreAnalyzedFieldManagedSchemaCloudTest.java:52)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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(java.base@9-ea/Thread.java:843)
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:43033/solr/managed-preanalyzed: No such path 
/schema/fields/field2
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:593)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:435)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:387)
        ... 45 more


FAILED:  
org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency

Error Message:
Path not found: /spellcheck/suggestions/[1]/suggestion

Stack Trace:
java.lang.RuntimeException: Path not found: 
/spellcheck/suggestions/[1]/suggestion
        at 
__randomizedtesting.SeedInfo.seed([82FBEFF3B881DE8E:85C6002376AE7F5]:0)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:900)
        at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:847)
        at 
org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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(java.base@9-ea/Thread.java:843)




Build Log:
[...truncated 11268 lines...]
   [junit4] Suite: org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/init-core-data-001
   [junit4]   2> 441849 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 441849 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001
   [junit4]   2> 441850 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 441850 INFO  (Thread-1158) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 441850 INFO  (Thread-1158) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 441950 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.ZkTestServer start zk server on port:41643
   [junit4]   2> 441954 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 441954 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 441955 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7f44fb{/solr,null,AVAILABLE}
   [junit4]   2> 441955 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4532d7{/solr,null,AVAILABLE}
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@94d624{HTTP/1.1,[http/1.1]}{127.0.0.1:43033}
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.Server Started @445435ms
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43033}
   [junit4]   2> 441957 ERROR (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@14a63d9{HTTP/1.1,[http/1.1]}{127.0.0.1:35261}
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.0
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.Server Started @445435ms
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=35261}
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-04T14:33:01.225655Z
   [junit4]   2> 441957 ERROR (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.0
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 441957 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-04T14:33:01.225885Z
   [junit4]   2> 441959 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 441959 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 441965 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 441967 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 441968 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41643/solr
   [junit4]   2> 441970 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41643/solr
   [junit4]   2> 441981 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43033_solr
   [junit4]   2> 441982 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35261_solr
   [junit4]   2> 441982 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=97049770794745860-127.0.0.1:43033_solr-n_0000000000) starting
   [junit4]   2> 441982 INFO  (zkCallback-1057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 441982 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 441986 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43033_solr
   [junit4]   2> 441986 INFO  (zkCallback-1057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 441986 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 442034 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node2/.
   [junit4]   2> 442045 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node1/.
   [junit4]   2> 442050 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 442051 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41643/solr 
ready
   [junit4]   2> 442061 INFO  (qtp8702853-5207) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=cloud-managed-preanalyzed&maxShardsPerNode=1&name=managed-preanalyzed&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 442062 INFO  (OverseerThreadFactory-2424-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection managed-preanalyzed
   [junit4]   2> 442169 INFO  (qtp8702853-5211) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=cloud-managed-preanalyzed&newCollection=true&name=managed-preanalyzed_shard2_replica1&action=CREATE&numShards=2&collection=managed-preanalyzed&shard=shard2&wt=javabin&version=2
   [junit4]   2> 442169 INFO  (qtp9625035-5206) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=cloud-managed-preanalyzed&newCollection=true&name=managed-preanalyzed_shard1_replica1&action=CREATE&numShards=2&collection=managed-preanalyzed&shard=shard1&wt=javabin&version=2
   [junit4]   2> 442273 INFO  (zkCallback-1057-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 442273 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 443177 INFO  (qtp9625035-5206) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 443178 INFO  (qtp8702853-5211) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 443183 INFO  (qtp9625035-5206) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 443183 INFO  (qtp8702853-5211) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 443193 INFO  (qtp8702853-5211) [    ] o.a.s.s.IndexSchema 
Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 443193 INFO  (qtp9625035-5206) [    ] o.a.s.s.IndexSchema 
Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 443194 INFO  (qtp9625035-5206) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'managed-preanalyzed_shard1_replica1' using configuration 
from collection managed-preanalyzed
   [junit4]   2> 443194 INFO  (qtp8702853-5211) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'managed-preanalyzed_shard2_replica1' using configuration 
from collection managed-preanalyzed
   [junit4]   2> 443194 INFO  (qtp8702853-5211) [    ] o.a.s.c.SolrCore 
[[managed-preanalyzed_shard2_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node1/managed-preanalyzed_shard2_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node1/./managed-preanalyzed_shard2_replica1/data/]
   [junit4]   2> 443194 INFO  (qtp9625035-5206) [    ] o.a.s.c.SolrCore 
[[managed-preanalyzed_shard1_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node2/managed-preanalyzed_shard1_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node2/./managed-preanalyzed_shard1_replica1/data/]
   [junit4]   2> 443201 INFO  (qtp8702853-5211) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 443201 INFO  (qtp8702853-5211) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 443201 INFO  (qtp9625035-5206) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 443201 INFO  (qtp9625035-5206) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 443206 INFO  (qtp8702853-5211) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 443206 INFO  (qtp8702853-5211) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 443206 INFO  (qtp9625035-5206) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 443206 INFO  (qtp9625035-5206) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 443206 INFO  (qtp8702853-5211) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1ad8306[managed-preanalyzed_shard2_replica1] main]
   [junit4]   2> 443206 INFO  (qtp9625035-5206) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2143ad[managed-preanalyzed_shard1_replica1] main]
   [junit4]   2> 443207 INFO  (qtp8702853-5211) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cloud-managed-preanalyzed
   [junit4]   2> 443207 INFO  (qtp9625035-5206) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cloud-managed-preanalyzed
   [junit4]   2> 443207 INFO  (qtp8702853-5211) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
   [junit4]   2> 443207 INFO  (qtp9625035-5206) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
   [junit4]   2> 443208 INFO  (qtp8702853-5211) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> 443208 INFO  (qtp9625035-5206) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> 443209 INFO  (qtp9625035-5206) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 443209 INFO  (qtp8702853-5211) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 443209 INFO  (searcherExecutor-2430-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher 
Searcher@1ad8306[managed-preanalyzed_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 443209 INFO  (searcherExecutor-2429-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher 
Searcher@2143ad[managed-preanalyzed_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 443210 INFO  (qtp8702853-5211) [    ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1552796334138851328
   [junit4]   2> 443210 INFO  (qtp9625035-5206) [    ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1552796334138851328
   [junit4]   2> 443214 INFO  (qtp8702853-5211) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 443214 INFO  (qtp8702853-5211) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 443214 INFO  (qtp8702853-5211) [    ] o.a.s.c.SyncStrategy 
Sync replicas to 
http://127.0.0.1:35261/solr/managed-preanalyzed_shard2_replica1/
   [junit4]   2> 443214 INFO  (qtp8702853-5211) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 443214 INFO  (qtp9625035-5206) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 443214 INFO  (qtp9625035-5206) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 443214 INFO  (qtp8702853-5211) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:35261/solr/managed-preanalyzed_shard2_replica1/ has no replicas
   [junit4]   2> 443214 INFO  (qtp9625035-5206) [    ] o.a.s.c.SyncStrategy 
Sync replicas to 
http://127.0.0.1:43033/solr/managed-preanalyzed_shard1_replica1/
   [junit4]   2> 443214 INFO  (qtp9625035-5206) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 443214 INFO  (qtp9625035-5206) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:43033/solr/managed-preanalyzed_shard1_replica1/ has no replicas
   [junit4]   2> 443216 INFO  (qtp8702853-5211) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:35261/solr/managed-preanalyzed_shard2_replica1/ shard2
   [junit4]   2> 443217 INFO  (qtp9625035-5206) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:43033/solr/managed-preanalyzed_shard1_replica1/ shard1
   [junit4]   2> 443319 INFO  (zkCallback-1057-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 443319 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 443367 INFO  (qtp8702853-5211) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 443367 INFO  (qtp9625035-5206) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 443371 INFO  (qtp9625035-5206) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=cloud-managed-preanalyzed&newCollection=true&name=managed-preanalyzed_shard1_replica1&action=CREATE&numShards=2&collection=managed-preanalyzed&shard=shard1&wt=javabin&version=2}
 status=0 QTime=1202
   [junit4]   2> 443371 INFO  (qtp8702853-5211) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=cloud-managed-preanalyzed&newCollection=true&name=managed-preanalyzed_shard2_replica1&action=CREATE&numShards=2&collection=managed-preanalyzed&shard=shard2&wt=javabin&version=2}
 status=0 QTime=1205
   [junit4]   2> 443373 INFO  (qtp8702853-5207) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 443470 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 443470 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/managed-preanalyzed/state.json] for collection 
[managed-preanalyzed] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 444063 INFO  
(OverseerCollectionConfigSetProcessor-97049770794745860-127.0.0.1:43033_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 444373 INFO  (qtp8702853-5207) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=cloud-managed-preanalyzed&maxShardsPerNode=1&name=managed-preanalyzed&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=2312
   [junit4]   2> 444384 INFO  
(TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testAdd2Fields
   [junit4]   2> 444393 INFO  (qtp8702853-5209) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 0 
   [junit4]   2> 444395 INFO  (qtp8702853-5209) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444399 INFO  (qtp8702853-5209) [    ] o.a.s.s.IndexSchema 
Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444400 INFO  (qtp8702853-5209) [    ] o.a.s.c.ZkController 
Persisted config data to node /configs/cloud-managed-preanalyzed/managed-schema 
   [junit4]   2> 444400 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/cloud-managed-preanalyzed/managed-schema, 
has occurred - updating schema from ZooKeeper ...
   [junit4]   2> 444400 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/cloud-managed-preanalyzed/managed-schema, 
has occurred - updating schema from ZooKeeper ...
   [junit4]   2> 444401 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
   [junit4]   2> 444401 INFO  (Thread-1177) [    ] o.a.s.c.SolrCore config 
update listener called for core managed-preanalyzed_shard1_replica1
   [junit4]   2> 444401 INFO  (qtp8702853-5209) [    ] 
o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 1 replicas to apply 
schema update version 1 for collection managed-preanalyzed
   [junit4]   2> 444402 INFO  (Thread-1177) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 1 
   [junit4]   2> 444402 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema 
name=managed-preanalyzed
   [junit4]   2> 444403 INFO  (Thread-1177) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444403 INFO  (Thread-1178) [    ] o.a.s.c.SolrCore config 
update listener called for core managed-preanalyzed_shard2_replica1
   [junit4]   2> 444405 INFO  (Thread-1178) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 1 
   [junit4]   2> 444405 INFO  (Thread-1177) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444405 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444406 INFO  (Thread-1177) [    ] o.a.s.c.SolrCore core reload 
managed-preanalyzed_shard1_replica1
   [junit4]   2> 444406 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 5 ms
   [junit4]   2> 444407 INFO  (Thread-1178) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444407 INFO  (qtp9625035-5198) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard1_replica1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 444408 INFO  (qtp8702853-5209) [    ] 
o.a.s.s.ManagedIndexSchema Took 7.0ms for 1 replicas to apply schema update 
version 1 for collection managed-preanalyzed
   [junit4]   2> 444408 INFO  (qtp8702853-5209) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard2_replica1]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=16
   [junit4]   2> 444408 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
   [junit4]   2> 444410 INFO  (Thread-1178) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444410 INFO  (Thread-1178) [    ] o.a.s.c.SolrCore core reload 
managed-preanalyzed_shard2_replica1
   [junit4]   2> 444411 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema 
name=managed-preanalyzed
   [junit4]   2> 444412 INFO  (Thread-1177) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 444413 INFO  (qtp8702853-5199) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard2_replica1]  webapp=/solr path=/schema/fields/field1 
params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 444415 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444415 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 6 ms
   [junit4]   2> 444415 INFO  (Thread-1178) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 444417 INFO  (qtp9625035-5206) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 1 
   [junit4]   2> 444418 INFO  (Thread-1177) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444419 INFO  (qtp9625035-5206) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444421 INFO  (Thread-1177) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444422 INFO  (Thread-1177) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'managed-preanalyzed_shard1_replica1' using configuration 
from collection managed-preanalyzed
   [junit4]   2> 444423 INFO  (qtp9625035-5206) [    ] o.a.s.s.IndexSchema 
Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444423 INFO  (Thread-1178) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444427 INFO  (Thread-1178) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444427 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/cloud-managed-preanalyzed/managed-schema, 
has occurred - updating schema from ZooKeeper ...
   [junit4]   2> 444428 INFO  (qtp9625035-5206) [    ] o.a.s.c.ZkController 
Persisted config data to node /configs/cloud-managed-preanalyzed/managed-schema 
   [junit4]   2> 444428 INFO  (Thread-1178) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'managed-preanalyzed_shard2_replica1' using configuration 
from collection managed-preanalyzed
   [junit4]   2> 444428 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/cloud-managed-preanalyzed/managed-schema, 
has occurred - updating schema from ZooKeeper ...
   [junit4]   2> 444429 INFO  (qtp9625035-5206) [    ] 
o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 1 replicas to apply 
schema update version 2 for collection managed-preanalyzed
   [junit4]   2> 444429 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 2 from ZooKeeper
   [junit4]   2> 444429 INFO  (Thread-1179) [    ] o.a.s.c.SolrCore config 
update listener called for core managed-preanalyzed_shard1_replica1
   [junit4]   2> 444429 INFO  (Thread-1178) [    ] o.a.s.c.SolrCore 
[[managed-preanalyzed_shard2_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node1/managed-preanalyzed_shard2_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node1/./managed-preanalyzed_shard2_replica1/data/]
   [junit4]   2> 444429 INFO  (Thread-1177) [    ] o.a.s.c.SolrCore 
[[managed-preanalyzed_shard1_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node2/managed-preanalyzed_shard1_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001/tempDir-001/node2/./managed-preanalyzed_shard1_replica1/data/]
   [junit4]   2> 444430 INFO  (Thread-1180) [    ] o.a.s.c.SolrCore config 
update listener called for core managed-preanalyzed_shard2_replica1
   [junit4]   2> 444430 INFO  (Thread-1179) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 2 
   [junit4]   2> 444431 INFO  (Thread-1180) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 2 
   [junit4]   2> 444431 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema 
name=managed-preanalyzed
   [junit4]   2> 444432 INFO  (Thread-1179) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444434 INFO  (Thread-1180) [    ] o.a.s.s.IndexSchema 
[managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
   [junit4]   2> 444435 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444436 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 6 ms
   [junit4]   2> 444436 INFO  (Thread-1179) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444436 INFO  (Thread-1180) [    ] o.a.s.s.IndexSchema Loaded 
schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444437 INFO  (Thread-1180) [    ] o.a.s.c.SolrCore core reload 
managed-preanalyzed_shard2_replica1
   [junit4]   2> 444437 INFO  (Thread-1179) [    ] o.a.s.c.SolrCore core reload 
managed-preanalyzed_shard1_replica1
   [junit4]   2> 444437 INFO  (Thread-1177) [    ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 444437 INFO  (Thread-1177) [    ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 444437 INFO  (Thread-1177) [    ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1e34e9b[managed-preanalyzed_shard1_replica1] main]
   [junit4]   2> 444437 INFO  (Thread-1178) [    ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 444437 INFO  (Thread-1178) [    ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 444437 INFO  (Thread-1178) [    ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@190ab9c[managed-preanalyzed_shard2_replica1] main]
   [junit4]   2> 444438 INFO  (Thread-1177) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cloud-managed-preanalyzed
   [junit4]   2> 444438 INFO  (Thread-1177) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
   [junit4]   2> 444438 INFO  (Thread-1177) [    ] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> 444438 INFO  (Thread-1178) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cloud-managed-preanalyzed
   [junit4]   2> 444438 INFO  (Thread-1177) [    ] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 444438 INFO  (Thread-1178) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
   [junit4]   2> 444438 INFO  (searcherExecutor-2442-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher 
Searcher@1e34e9b[managed-preanalyzed_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 444439 INFO  (Thread-1178) [    ] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> 444439 INFO  (Thread-1177) [    ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1552796335427551232
   [junit4]   2> 444439 INFO  (qtp8702853-5201) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard2_replica1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 444439 INFO  (Thread-1178) [    ] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 444440 INFO  (Thread-1178) [    ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1552796335428599808
   [junit4]   2> 444442 INFO  (searcherExecutor-2441-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher 
Searcher@190ab9c[managed-preanalyzed_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 444442 INFO  (Thread-1177) [    ] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 444442 INFO  (Thread-1177) [    ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1158dc5[managed-preanalyzed_shard1_replica1] main]
   [junit4]   2> 444442 INFO  (searcherExecutor-2442-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher 
Searcher@1158dc5[managed-preanalyzed_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 444443 INFO  (Thread-1178) [    ] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 444443 INFO  (Thread-1178) [    ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2cf4a0[managed-preanalyzed_shard2_replica1] main]
   [junit4]   2> 444443 INFO  (Thread-1178) [    ] o.a.s.c.SolrCore 
[managed-preanalyzed_shard2_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1034bc2
   [junit4]   2> 444443 INFO  (qtp9625035-5206) [    ] 
o.a.s.s.ManagedIndexSchema Took 14.0ms for 1 replicas to apply schema update 
version 2 for collection managed-preanalyzed
   [junit4]   2> 444444 INFO  (qtp9625035-5206) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard1_replica1]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=27
   [junit4]   2> 444444 INFO  (qtp9625035-5206) [    ] o.a.s.c.SolrCore 
[managed-preanalyzed_shard1_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@14f9312
   [junit4]   2> 444444 INFO  (searcherExecutor-2441-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher 
Searcher@2cf4a0[managed-preanalyzed_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 444446 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 2 from ZooKeeper
   [junit4]   2> 444446 INFO  (qtp8702853-5211) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard2_replica1]  webapp=/solr path=/schema/fields/field2 
params={wt=javabin&version=2} status=404 QTime=0
   [junit4]   2> 444448 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema 
name=managed-preanalyzed
   [junit4]   2> 444448 INFO  (qtp9625035-5210) [    ] o.a.s.c.S.Request 
[managed-preanalyzed_shard1_replica1]  webapp=/solr path=/schema/fields/field2 
params={wt=javabin&version=2} status=404 QTime=0
   [junit4]   2> 444449 ERROR 
(TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.c.s.i.CloudSolrClient Request to collection managed-preanalyzed 
failed due to (404) 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:43033/solr/managed-preanalyzed: No such path 
/schema/fields/field2, retry? 0
   [junit4]   2> 444449 INFO  
(TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testAdd2Fields
   [junit4]   2> 444466 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
   [junit4]   2> 444466 INFO  (zkCallback-1057-thread-3) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 20 ms
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=PreAnalyzedFieldManagedSchemaCloudTest -Dtests.method=testAdd2Fields 
-Dtests.seed=82FBEFF3B881DE8E -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=ug-CN -Dtests.timezone=America/Winnipeg -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.09s J1 | 
PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[http://127.0.0.1:35261/solr/managed-preanalyzed, 
http://127.0.0.1:43033/solr/managed-preanalyzed]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([82FBEFF3B881DE8E:2AEE5D1864874D78]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:414)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1344)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1095)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1037)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
   [junit4]    >        at 
org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.addField(PreAnalyzedFieldManagedSchemaCloudTest.java:61)
   [junit4]    >        at 
org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields(PreAnalyzedFieldManagedSchemaCloudTest.java:52)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:43033/solr/managed-preanalyzed: No such path 
/schema/fields/field2
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:593)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:435)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:387)
   [junit4]    >        ... 45 more
   [junit4]   2> 444470 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@94d624{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 444471 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28551504
   [junit4]   2> 444471 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@14a63d9{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 444472 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=3351604
   [junit4]   2> 444472 INFO  (coreCloseExecutor-2449-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@12f5669
   [junit4]   2> 444474 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=97049770794745860-127.0.0.1:43033_solr-n_0000000000) closing
   [junit4]   2> 444474 INFO  
(OverseerStateUpdate-97049770794745860-127.0.0.1:43033_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43033_solr
   [junit4]   2> 444474 INFO  (coreCloseExecutor-2451-thread-1) [    ] 
o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@106ad7c
   [junit4]   2> 444475 INFO  (zkCallback-1059-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 444475 INFO  (Thread-1179) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 444475 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35261_solr
   [junit4]   2> 444476 INFO  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=97049770794745862-127.0.0.1:35261_solr-n_0000000001) starting
   [junit4]   2> 444478 ERROR (Thread-1179) [    ] 
o.a.s.s.ManagedIndexSchemaFactory Error attempting to access 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:126)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:45)
   [junit4]   2>        at 
org.apache.solr.schema.IndexSchemaFactory.buildIndexSchema(IndexSchemaFactory.java:75)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.createIndexSchema(ConfigSetService.java:107)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:942)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2714)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 444479 WARN  (Thread-1179) [    ] o.a.s.c.ZkController 
listener throws error
   [junit4]   2> org.apache.solr.common.SolrException: Unable to reload core 
[managed-preanalyzed_shard1_replica1]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:950)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2714)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not 
load conf for core managed-preanalyzed_shard1_replica1: Error attempting to 
access /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:85)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:942)
   [junit4]   2>        ... 3 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Error 
attempting to access /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:141)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:45)
   [junit4]   2>        at 
org.apache.solr.schema.IndexSchemaFactory.buildIndexSchema(IndexSchemaFactory.java:75)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.createIndexSchema(ConfigSetService.java:107)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
   [junit4]   2>        ... 4 more
   [junit4]   2> Caused by: 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:126)
   [junit4]   2>        ... 8 more
   [junit4]   2> 444483 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=97049770794745862-127.0.0.1:35261_solr-n_0000000001) closing
   [junit4]   2> 444484 INFO  
(OverseerStateUpdate-97049770794745862-127.0.0.1:35261_solr-n_0000000001) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35261_solr
   [junit4]   2> 444484 INFO  (Thread-1180) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 444484 WARN  (zkCallback-1059-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 444484 INFO  
(OverseerCollectionConfigSetProcessor-97049770794745862-127.0.0.1:35261_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor According to ZK I 
(id=97049770794745862-127.0.0.1:35261_solr-n_0000000001) am no longer a leader.
   [junit4]   2> 444485 INFO  (jetty-launcher-1048-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4532d7{/solr,null,UNAVAILABLE}
   [junit4]   2> 444485 ERROR 
(OverseerCollectionConfigSetProcessor-97049770794745862-127.0.0.1:35261_solr-n_0000000001)
 [    ] o.a.s.c.OverseerTaskProcessor 
:org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode 
= Session expired for /overseer/collection-queue-work
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1472)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:339)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:336)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:336)
   [junit4]   2>        at 
org.apache.solr.cloud.DistributedQueue.fetchZkChildren(DistributedQueue.java:299)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskQueue.getTailId(OverseerTaskQueue.java:264)
   [junit4]   2>        at 
org.apache.solr.cloud.OverseerTaskProcessor.run(OverseerTaskProcessor.java:162)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 
   [junit4]   2> 444489 ERROR (Thread-1180) [    ] 
o.a.s.s.ManagedIndexSchemaFactory Error attempting to access 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2> org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for 
/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:126)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:45)
   [junit4]   2>        at 
org.apache.solr.schema.IndexSchemaFactory.buildIndexSchema(IndexSchemaFactory.java:75)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.createIndexSchema(ConfigSetService.java:107)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:942)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2714)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 444489 WARN  (Thread-1180) [    ] o.a.s.c.ZkController 
listener throws error
   [junit4]   2> org.apache.solr.common.SolrException: Unable to reload core 
[managed-preanalyzed_shard2_replica1]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:950)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2714)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$fireEventListeners$4(ZkController.java:2448)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not 
load conf for core managed-preanalyzed_shard2_replica1: Error attempting to 
access /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:85)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:942)
   [junit4]   2>        ... 3 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Error 
attempting to access /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:141)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:45)
   [junit4]   2>        at 
org.apache.solr.schema.IndexSchemaFactory.buildIndexSchema(IndexSchemaFactory.java:75)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.createIndexSchema(ConfigSetService.java:107)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:78)
   [junit4]   2>        ... 4 more
   [junit4]   2> Caused by: 
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = 
Session expired for /configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
   [junit4]   2>        at 
org.apache.solr.schema.ManagedIndexSchemaFactory.create(ManagedIndexSchemaFactory.java:126)
   [junit4]   2>        ... 8 more
   [junit4]   2> 445974 WARN  (zkCallback-1057-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 445975 INFO  (jetty-launcher-1048-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7f44fb{/solr,null,UNAVAILABLE}
   [junit4]   2> 445975 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41643 41643
   [junit4]   2> 446080 INFO  (Thread-1158) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:41643 41643
   [junit4]   2> 446080 WARN  (Thread-1158) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/configs/cloud-managed-preanalyzed
   [junit4]   2>        4       
/solr/configs/cloud-managed-preanalyzed/managed-schema
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2>        3       /solr/collections/managed-preanalyzed/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/overseer/queue
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 446081 INFO  
(SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[82FBEFF3B881DE8E]-worker) [ 
   ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_82FBEFF3B881DE8E-001
   [junit4]   2> Dec 04, 2016 2:33:05 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=Lucene62, 
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=ug-CN, 
timezone=America/Winnipeg
   [junit4]   2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 9-ea 
(32-bit)/cpus=12,threads=1,free=359977504,total=523239424
   [junit4]   2> NOTE: All tests run in this JVM: [TestFieldCacheSortRandom, 
OverseerCollectionConfigSetProcessorTest, TestMiniSolrCloudClusterSSL, 
SolrInfoMBeanTest, SpatialFilterTest, ChaosMonkeySafeLeaderTest, 
TestRTimerTree, CSVRequestHandlerTest, TestStressVersions, 
TestFieldCacheReopen, TestHashQParserPlugin, TestTrie, TestMissingGroups, 
TestSchemaResource, TestSubQueryTransformerDistrib, TestDistributedGrouping, 
ConvertedLegacyTest, OverseerStatusTest, TestAnalyzeInfixSuggestions, 
TestSystemIdResolver, BJQParserTest, DistributedQueryComponentOptimizationTest, 
SampleTest, BasicAuthIntegrationTest, TestFreeTextSuggestions, 
SearchHandlerTest, AliasIntegrationTest, URLClassifyProcessorTest, 
HdfsBasicDistributedZk2Test, TestSolr4Spatial2, TestCloudPivotFacet, 
CursorMarkTest, TestConfigSetsAPIExclusivity, TestCursorMarkWithoutUniqueKey, 
DirectSolrSpellCheckerTest, TestClusterStateMutator, HdfsDirectoryFactoryTest, 
DocumentBuilderTest, SystemInfoHandlerTest, DistributedMLTComponentTest, 
TestLegacyFieldCache, TestUseDocValuesAsStored2, ConfigSetsAPITest, 
TestShortCircuitedRequests, SliceStateTest, TestSolrConfigHandlerCloud, 
SimplePostToolTest, CollectionsAPIAsyncDistributedZkTest, SortSpecParsingTest, 
TestManagedSchemaThreadSafety, DistributedFacetPivotSmallTest, 
SoftAutoCommitTest, DistributedDebugComponentTest, ReplicaListTransformerTest, 
DistributedTermsComponentTest, PreAnalyzedFieldManagedSchemaCloudTest]
   [junit4] Completed [186/658 (1!)] on J1 in 5.00s, 1 test, 1 error <<< 
FAILURES!

[...truncated 261 lines...]
   [junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_82FBEFF3B881DE8E-001/init-core-data-001
   [junit4]   2> 718967 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 718968 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 718969 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 719043 WARN  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 719043 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 719055 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 719110 WARN  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 719112 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 719134 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 719137 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 719201 WARN  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 719202 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 719212 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 719300 WARN  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 719302 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 719320 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 719321 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_82FBEFF3B881DE8E-001/init-core-data-001/]
   [junit4]   2> 719322 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7899931874676082]
   [junit4]   2> 719327 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 719327 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 719327 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 719327 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@d07b91[collection1] main]
   [junit4]   2> 719328 WARN  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 719328 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 719386 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: default
   [junit4]   2> 719414 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: default_teststop
   [junit4]   2> 719414 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 719414 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 719445 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: threshold
   [junit4]   2> 719445 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
   [junit4]   2> 719445 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: threshold_direct
   [junit4]   2> 719543 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: multipleFields
   [junit4]   2> 719669 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: freq
   [junit4]   2> 719713 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for 
spellchecker: fqcn
   [junit4]   2> 719713 INFO  (coreLoadExecutor-8045-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 719714 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 719715 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 719716 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
default_teststop
   [junit4]   2> 719717 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
   [junit4]   2> 719718 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[0]} 0 1
   [junit4]   2> 719718 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 719718 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
direct_lowerfilt
   [junit4]   2> 719718 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 719718 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 719719 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[1]} 0 0
   [junit4]   2> 719719 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[2]} 0 0
   [junit4]   2> 719719 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[3]} 0 0
   [junit4]   2> 719720 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
threshold_direct
   [junit4]   2> 719720 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 719720 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[4]} 0 0
   [junit4]   2> 719720 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[5]} 0 0
   [junit4]   2> 719720 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[6]} 0 0
   [junit4]   2> 719720 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[7]} 0 0
   [junit4]   2> 719721 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[8]} 0 0
   [junit4]   2> 719721 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{add=[9]} 0 0
   [junit4]   2> 719721 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 719721 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@126c656
   [junit4]   2> 719721 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 719723 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 719725 WARN  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping 
onDeckSearchers=2
   [junit4]   2> 719726 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 719727 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ac69ad[collection1] main]
   [junit4]   2> 719727 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 719727 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 719729 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 719729 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d07b91[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 719729 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 719731 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
default_teststop
   [junit4]   2> 719732 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 719732 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
direct_lowerfilt
   [junit4]   2> 719732 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 719732 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 719734 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
threshold_direct
   [junit4]   2> 719734 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 719735 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 719738 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 719739 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 719741 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 719742 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 719743 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ac69ad[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c10)))}
   [junit4]   2> 719743 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 21
   [junit4]   2> 719745 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true}
 hits=0 status=0 QTime=1
   [junit4]   2> 719745 ERROR 
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not 
found: /spellcheck/suggestions/[1]/suggestion
   [junit4]   2>  expected 
=/spellcheck/suggestions/[1]/suggestion==[{'word':'document','freq':2}]
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":1},
   [junit4]   2>   "response":{"numFound":0,"start":0,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[],
   [junit4]   2>     "correctlySpelled":false}}
   [junit4]   2> 
   [junit4]   2>  request = 
q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true
   [junit4]   2> 719746 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
   [junit4]   2> 719746 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM 
INDEX
   [junit4]   2> 719746 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 719746 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 719746 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@126c656
   [junit4]   2> 719747 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e54aa[collection1] main]
   [junit4]   2> 719747 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 719747 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 719810 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
default_teststop
   [junit4]   2> 719847 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 719892 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
threshold_direct
   [junit4]   2> 719892 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
multipleFields
   [junit4]   2> 719935 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 719991 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 720042 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5e54aa[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 720042 INFO  
(TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[82FBEFF3B881DE8E])
 [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null params={}{commit=} 0 295
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency 
-Dtests.seed=82FBEFF3B881DE8E -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=no -Dtests.timezone=America/Boa_Vista -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.33s J1 | 
SpellCheckComponentTest.testThresholdTokenFrequency <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Path not found: 
/spellcheck/suggestions/[1]/suggestion
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([82FBEFF3B881DE8E:85C6002376AE7F5]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:900)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:847)
   [junit4]    >        at 
org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 720044 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testCorrectSpelling
   [junit4]   2> 720045 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[0]} 0 0
   [junit4]   2> 720045 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 720045 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 720045 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 720045 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[4]} 0 0
   [junit4]   2> 720046 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[5]} 0 0
   [junit4]   2> 720046 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[6]} 0 0
   [junit4]   2> 720046 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[7]} 0 0
   [junit4]   2> 720046 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[8]} 0 0
   [junit4]   2> 720046 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[9]} 0 0
   [junit4]   2> 720047 INFO  
(TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[82FBEFF3B881DE8E]) [    
] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 720047 I

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

.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@126c656
   [junit4]   2> 735444 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@178a329[collection1] main]
   [junit4]   2> 735444 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 735444 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 735617 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
default_teststop
   [junit4]   2> 735684 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 735860 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
threshold_direct
   [junit4]   2> 735860 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
multipleFields
   [junit4]   2> 736025 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 736175 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 736332 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@178a329[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(6.4.0):c10)))}
   [junit4]   2> 736333 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 892
   [junit4]   2> 736334 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=documemt&qt=spellCheckCompRH&spellcheck.dictionary=perDict&json.nl=map&spellcheck..perDict.foo=bar&spellcheck=true&spellcheck..perDict.bar=foo&wt=xml&spellcheck.build=true}
 hits=0 status=0 QTime=0
   [junit4]   2> 736334 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
   [junit4]   2> 736334 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 736334 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 736335 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 736335 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@126c656
   [junit4]   2> 736335 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1a48017[collection1] main]
   [junit4]   2> 736335 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 736335 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 736398 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
default_teststop
   [junit4]   2> 736447 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 736500 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
threshold_direct
   [junit4]   2> 736500 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: 
multipleFields
   [junit4]   2> 736546 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 736601 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 736648 INFO  (searcherExecutor-8046-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1a48017[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 736648 INFO  
(TEST-SpellCheckComponentTest.testPerDictionary-seed#[82FBEFF3B881DE8E]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{commit=} 0 313
   [junit4]   2> 736649 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 736649 INFO  
(SUITE-SpellCheckComponentTest-seed#[82FBEFF3B881DE8E]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=4034495
   [junit4]   2> 736649 INFO  (coreCloseExecutor-8050-thread-1) [    ] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1635786
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_82FBEFF3B881DE8E-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{start1=Lucene50(blocksize=128), range_facet_l_dv=Lucene50(blocksize=128), 
multiDefault=PostingsFormat(name=Direct), intDefault=Lucene50(blocksize=128), 
range_facet_l=PostingsFormat(name=Direct), 
lowerfilt1and2=PostingsFormat(name=Direct), 
end4=PostingsFormat(name=LuceneVarGapFixedInterval), 
end3=Lucene50(blocksize=128), end2=Lucene50(blocksize=128), 
end1=PostingsFormat(name=Direct), lowerfilt=PostingsFormat(name=Direct), 
gram1=PostingsFormat(name=Direct), id=Lucene50(blocksize=128), 
range_facet_i_dv=PostingsFormat(name=Direct), gram2=Lucene50(blocksize=128), 
gram3=Lucene50(blocksize=128), 
start3=PostingsFormat(name=LuceneVarGapFixedInterval), 
gram4=PostingsFormat(name=LuceneVarGapFixedInterval), 
start2=PostingsFormat(name=Direct), word=PostingsFormat(name=Direct), 
timestamp=PostingsFormat(name=Direct), start4=Lucene50(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1760, 
maxMBSortInHeap=6.8647775989048405, 
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=no, 
timezone=America/Boa_Vista
   [junit4]   2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 9-ea 
(32-bit)/cpus=12,threads=1,free=317892296,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestFieldCacheSortRandom, 
OverseerCollectionConfigSetProcessorTest, TestMiniSolrCloudClusterSSL, 
SolrInfoMBeanTest, SpatialFilterTest, ChaosMonkeySafeLeaderTest, 
TestRTimerTree, CSVRequestHandlerTest, TestStressVersions, 
TestFieldCacheReopen, TestHashQParserPlugin, TestTrie, TestMissingGroups, 
TestSchemaResource, TestSubQueryTransformerDistrib, TestDistributedGrouping, 
ConvertedLegacyTest, OverseerStatusTest, TestAnalyzeInfixSuggestions, 
TestSystemIdResolver, BJQParserTest, DistributedQueryComponentOptimizationTest, 
SampleTest, BasicAuthIntegrationTest, TestFreeTextSuggestions, 
SearchHandlerTest, AliasIntegrationTest, URLClassifyProcessorTest, 
HdfsBasicDistributedZk2Test, TestSolr4Spatial2, TestCloudPivotFacet, 
CursorMarkTest, TestConfigSetsAPIExclusivity, TestCursorMarkWithoutUniqueKey, 
DirectSolrSpellCheckerTest, TestClusterStateMutator, HdfsDirectoryFactoryTest, 
DocumentBuilderTest, SystemInfoHandlerTest, DistributedMLTComponentTest, 
TestLegacyFieldCache, TestUseDocValuesAsStored2, ConfigSetsAPITest, 
TestShortCircuitedRequests, SliceStateTest, TestSolrConfigHandlerCloud, 
SimplePostToolTest, CollectionsAPIAsyncDistributedZkTest, SortSpecParsingTest, 
TestManagedSchemaThreadSafety, DistributedFacetPivotSmallTest, 
SoftAutoCommitTest, DistributedDebugComponentTest, ReplicaListTransformerTest, 
DistributedTermsComponentTest, PreAnalyzedFieldManagedSchemaCloudTest, 
DirectSolrConnectionTest, CdcrUpdateLogTest, DistribJoinFromCollectionTest, 
TestHdfsBackupRestoreCore, EchoParamsTest, BlockDirectoryTest, 
SuggestComponentContextFilterQueryTest, TemplateUpdateProcessorTest, 
BaseCdcrDistributedZkTest, CopyFieldTest, ClusterStateUpdateTest, 
CoreSorterTest, DeleteNodeTest, TestUninvertingReader, TestConfigSets, 
TestCSVResponseWriter, TestNonDefinedSimilarityFactory, FileUtilsTest, 
TestFieldSortValues, SolrIndexConfigTest, HighlighterTest, 
TestSweetSpotSimilarityFactory, ShardRoutingCustomTest, TestCharFilters, 
JsonLoaderTest, TestQueryWrapperFilter, TestQueryUtils, 
TestCustomDocTransformer, DocValuesNotIndexedTest, BlobRepositoryCloudTest, 
ZkSolrClientTest, TermsComponentTest, TestExactSharedStatsCache, DocValuesTest, 
UUIDUpdateProcessorFallbackTest, SolrCmdDistributorTest, 
TestSimpleTrackingShardHandler, UpdateRequestProcessorFactoryTest, 
SpellCheckCollatorTest, TestCopyFieldCollectionResource, 
TestReRankQParserPlugin, TestWordDelimiterFilterFactory, TestFastOutputStream, 
TestCollapseQParserPlugin, TestIntervalFaceting, 
SchemaVersionSpecificBehaviorTest, SolrCLIZkUtilsTest, 
TestSlowCompositeReaderWrapper, RequestLoggingTest, TestConfigOverlay, 
TestStressLiveNodes, TestSuggestSpellingConverter, SpellCheckComponentTest]
   [junit4] Completed [265/658 (2!)] on J1 in 17.72s, 11 tests, 1 error <<< 
FAILURES!

[...truncated 51306 lines...]

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

Reply via email to