You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/12/01 09:04:11 UTC
[JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_102) - Build # 2312
- Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2312/
Java: 32bit/jdk1.8.0_102 -server -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.schema.PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields
Error Message:
No live SolrServers available to handle this request:[https://127.0.0.1:36635/solr/managed-preanalyzed, https://127.0.0.1:42686/solr/managed-preanalyzed]
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:36635/solr/managed-preanalyzed, https://127.0.0.1:42686/solr/managed-preanalyzed]
at __randomizedtesting.SeedInfo.seed([ADC7F423B7BCC7F2:5D246C86BBA5404]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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(Thread.java:745)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:36635/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
Build Log:
[...truncated 12627 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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/init-core-data-001
[junit4] 2> 1873456 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1873457 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001
[junit4] 2> 1873458 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1873458 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1873458 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1873558 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:39208
[junit4] 2> 1873565 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1873565 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1873572 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c904de{/solr,null,AVAILABLE}
[junit4] 2> 1873574 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3c9264{/solr,null,AVAILABLE}
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@42ce09{SSL,[ssl, http/1.1]}{127.0.0.1:36635}
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@833b91{SSL,[ssl, http/1.1]}{127.0.0.1:42686}
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.Server Started @1875905ms
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.Server Started @1875905ms
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36635}
[junit4] 2> 1873579 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42686}
[junit4] 2> 1873580 ERROR (jetty-launcher-2034-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1873580 ERROR (jetty-launcher-2034-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-01T08:45:15.788Z
[junit4] 2> 1873580 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-01T08:45:15.788Z
[junit4] 2> 1873582 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1873582 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1873587 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1873587 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1873587 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39208/solr
[junit4] 2> 1873587 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39208/solr
[junit4] 2> 1873590 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x158b98f24130004, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1873600 INFO (jetty-launcher-2034-thread-2) [n:127.0.0.1:42686_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42686_solr
[junit4] 2> 1873600 INFO (jetty-launcher-2034-thread-1) [n:127.0.0.1:36635_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36635_solr
[junit4] 2> 1873600 INFO (jetty-launcher-2034-thread-2) [n:127.0.0.1:42686_solr ] o.a.s.c.Overseer Overseer (id=97031416425152518-127.0.0.1:42686_solr-n_0000000000) starting
[junit4] 2> 1873602 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1873602 INFO (zkCallback-2045-thread-1-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1873605 INFO (jetty-launcher-2034-thread-2) [n:127.0.0.1:42686_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42686_solr
[junit4] 2> 1873605 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1873605 INFO (zkCallback-2045-thread-1-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1873658 INFO (jetty-launcher-2034-thread-1) [n:127.0.0.1:36635_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node1/.
[junit4] 2> 1873756 INFO (jetty-launcher-2034-thread-2) [n:127.0.0.1:42686_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node2/.
[junit4] 2> 1873760 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1873760 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39208/solr ready
[junit4] 2> 1873837 INFO (qtp24475439-12688) [n:127.0.0.1:42686_solr ] 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> 1873838 INFO (OverseerThreadFactory-5995-thread-1-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.c.CreateCollectionCmd Create collection managed-preanalyzed
[junit4] 2> 1873946 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr ] 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> 1874011 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr ] 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> 1874113 INFO (zkCallback-2045-thread-1-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] 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> 1874113 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] 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> 1874954 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1874962 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1874970 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1874970 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'managed-preanalyzed_shard1_replica1' using configuration from collection managed-preanalyzed
[junit4] 2> 1874971 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] 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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node2/managed-preanalyzed_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node2/./managed-preanalyzed_shard1_replica1/data/]
[junit4] 2> 1874979 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1874979 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1874981 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1874981 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1874981 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1941b0b[managed-preanalyzed_shard1_replica1] main]
[junit4] 2> 1874982 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/cloud-managed-preanalyzed
[junit4] 2> 1874982 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
[junit4] 2> 1874982 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1874982 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1874982 INFO (searcherExecutor-6000-thread-1-processing-n:127.0.0.1:42686_solr x:managed-preanalyzed_shard1_replica1 s:shard1 c:managed-preanalyzed r:core_node1) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher Searcher@1941b0b[managed-preanalyzed_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1874983 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552502664400470016
[junit4] 2> 1874986 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1874986 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1874986 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42686/solr/managed-preanalyzed_shard1_replica1/
[junit4] 2> 1874986 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1874986 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:42686/solr/managed-preanalyzed_shard1_replica1/ has no replicas
[junit4] 2> 1874988 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42686/solr/managed-preanalyzed_shard1_replica1/ shard1
[junit4] 2> 1875017 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1875022 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1875025 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1875025 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'managed-preanalyzed_shard2_replica1' using configuration from collection managed-preanalyzed
[junit4] 2> 1875026 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node1/managed-preanalyzed_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node1/./managed-preanalyzed_shard2_replica1/data/]
[junit4] 2> 1875032 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1875032 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1875033 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1875033 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1875033 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8e0d09[managed-preanalyzed_shard2_replica1] main]
[junit4] 2> 1875034 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/cloud-managed-preanalyzed
[junit4] 2> 1875034 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
[junit4] 2> 1875034 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1875034 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1875034 INFO (searcherExecutor-6005-thread-1-processing-n:127.0.0.1:36635_solr x:managed-preanalyzed_shard2_replica1 s:shard2 c:managed-preanalyzed r:core_node2) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher Searcher@8e0d09[managed-preanalyzed_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1875034 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552502664453947392
[junit4] 2> 1875055 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1875055 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1875055 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:36635/solr/managed-preanalyzed_shard2_replica1/
[junit4] 2> 1875055 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1875055 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:36635/solr/managed-preanalyzed_shard2_replica1/ has no replicas
[junit4] 2> 1875057 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:36635/solr/managed-preanalyzed_shard2_replica1/ shard2
[junit4] 2> 1875158 INFO (zkCallback-2045-thread-1-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] 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> 1875158 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] 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> 1875189 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1875190 INFO (qtp24475439-12703) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] 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=1244
[junit4] 2> 1875207 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1875212 INFO (qtp18605929-12687) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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=1201
[junit4] 2> 1875214 INFO (qtp24475439-12688) [n:127.0.0.1:42686_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 1875321 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] 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> 1875321 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] 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> 1875840 INFO (OverseerCollectionConfigSetProcessor-97031416425152518-127.0.0.1:42686_solr-n_0000000000) [n:127.0.0.1:42686_solr ] 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> 1876214 INFO (qtp24475439-12688) [n:127.0.0.1:42686_solr ] 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=2377
[junit4] 2> 1876230 INFO (TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[ADC7F423B7BCC7F2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAdd2Fields
[junit4] 2> 1876244 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.SchemaManager managed schema loaded . version : 0
[junit4] 2> 1876246 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876249 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876257 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ZkController Persisted config data to node /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1876257 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] 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> 1876257 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] 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> 1876258 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1876258 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrCore config update listener called for core managed-preanalyzed_shard1_replica1
[junit4] 2> 1876259 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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> 1876259 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.s.SchemaManager managed schema loaded . version : 1
[junit4] 2> 1876259 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876261 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876261 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrCore config update listener called for core managed-preanalyzed_shard2_replica1
[junit4] 2> 1876261 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.s.SchemaManager managed schema loaded . version : 1
[junit4] 2> 1876263 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876263 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876263 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 5 ms
[junit4] 2> 1876263 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876265 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrCore core reload managed-preanalyzed_shard1_replica1
[junit4] 2> 1876267 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876267 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrCore core reload managed-preanalyzed_shard2_replica1
[junit4] 2> 1876291 INFO (qtp24475439-12688) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] 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=20
[junit4] 2> 1876291 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1876291 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.ManagedIndexSchema Took 33.0ms for 1 replicas to apply schema update version 1 for collection managed-preanalyzed
[junit4] 2> 1876292 INFO (qtp18605929-12689) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.S.Request [managed-preanalyzed_shard2_replica1] webapp=/solr path=/schema params={wt=javabin&version=2} status=0 QTime=48
[junit4] 2> 1876292 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1876294 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1876294 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876297 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876297 INFO (qtp24475439-12699) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.S.Request [managed-preanalyzed_shard1_replica1] webapp=/solr path=/schema/fields/field1 params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1876297 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 4 ms
[junit4] 2> 1876297 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876299 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876300 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876302 INFO (Thread-3148) [n:127.0.0.1:42686_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'managed-preanalyzed_shard1_replica1' using configuration from collection managed-preanalyzed
[junit4] 2> 1876303 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876302 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.SchemaManager managed schema loaded . version : 1
[junit4] 2> 1876310 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] 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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node2/managed-preanalyzed_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node2/./managed-preanalyzed_shard1_replica1/data/]
[junit4] 2> 1876311 INFO (Thread-3149) [n:127.0.0.1:36635_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'managed-preanalyzed_shard2_replica1' using configuration from collection managed-preanalyzed
[junit4] 2> 1876311 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node1/managed-preanalyzed_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001/tempDir-001/node1/./managed-preanalyzed_shard2_replica1/data/]
[junit4] 2> 1876312 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876316 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876316 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.ZkController Persisted config data to node /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1876316 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] 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> 1876316 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] 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> 1876317 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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> 1876317 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1876317 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1876317 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@160aae[managed-preanalyzed_shard2_replica1] main]
[junit4] 2> 1876317 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrCore config update listener called for core managed-preanalyzed_shard2_replica1
[junit4] 2> 1876317 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1876317 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1876317 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bea022[managed-preanalyzed_shard1_replica1] main]
[junit4] 2> 1876317 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/cloud-managed-preanalyzed
[junit4] 2> 1876318 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
[junit4] 2> 1876318 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.s.SchemaManager managed schema loaded . version : 2
[junit4] 2> 1876318 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 2 from ZooKeeper
[junit4] 2> 1876318 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1876318 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrCore config update listener called for core managed-preanalyzed_shard1_replica1
[junit4] 2> 1876318 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1876319 INFO (searcherExecutor-6012-thread-1-processing-n:127.0.0.1:36635_solr x:managed-preanalyzed_shard2_replica1 s:shard2 c:managed-preanalyzed r:core_node2) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher Searcher@160aae[managed-preanalyzed_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1876319 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552502665801367552
[junit4] 2> 1876320 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/cloud-managed-preanalyzed
[junit4] 2> 1876321 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876321 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/cloud-managed-preanalyzed
[junit4] 2> 1876321 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876321 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/cloud-managed-preanalyzed/managed-schema
[junit4] 2> 1876322 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1876322 INFO (Thread-3149) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c7ee00[managed-preanalyzed_shard2_replica1] main]
[junit4] 2> 1876322 INFO (searcherExecutor-6012-thread-1-processing-n:127.0.0.1:36635_solr x:managed-preanalyzed_shard2_replica1 s:shard2 c:managed-preanalyzed r:core_node2) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] Registered new searcher Searcher@1c7ee00[managed-preanalyzed_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1876324 INFO (qtp24475439-12749) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=1) before returning version!
[junit4] 2> 1876324 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.s.SchemaManager managed schema loaded . version : 2
[junit4] 2> 1876324 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1876324 INFO (searcherExecutor-6011-thread-1-processing-n:127.0.0.1:42686_solr x:managed-preanalyzed_shard1_replica1 s:shard1 c:managed-preanalyzed r:core_node1) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher Searcher@1bea022[managed-preanalyzed_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1876326 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552502665808707584
[junit4] 2> 1876326 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876326 INFO (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 8 ms
[junit4] 2> 1876327 INFO (qtp24475439-12749) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.S.Request [managed-preanalyzed_shard1_replica1] webapp=/solr path=/schema/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 1876327 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876327 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrCore core reload managed-preanalyzed_shard2_replica1
[junit4] 2> 1876327 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.s.ManagedIndexSchema Took 10.0ms for 1 replicas to apply schema update version 2 for collection managed-preanalyzed
[junit4] 2> 1876327 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.S.Request [managed-preanalyzed_shard2_replica1] webapp=/solr path=/schema params={wt=javabin&version=2} status=0 QTime=25
[junit4] 2> 1876327 INFO (qtp18605929-12698) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@54ba4
[junit4] 2> 1876328 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard1_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876329 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1876329 INFO (Thread-3148) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@149bb1[managed-preanalyzed_shard1_replica1] main]
[junit4] 2> 1876329 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 2 from ZooKeeper
[junit4] 2> 1876330 INFO (qtp24475439-12699) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] 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> 1876331 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876331 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@7285a3
[junit4] 2> 1876331 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876331 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrCore core reload managed-preanalyzed_shard1_replica1
[junit4] 2> 1876333 INFO (searcherExecutor-6011-thread-1-processing-n:127.0.0.1:42686_solr x:managed-preanalyzed_shard1_replica1 s:shard1 c:managed-preanalyzed r:core_node1) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] Registered new searcher Searcher@149bb1[managed-preanalyzed_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1876333 INFO (qtp18605929-12700) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] 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> 1876333 ERROR (TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[ADC7F423B7BCC7F2]) [ ] 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 https://127.0.0.1:36635/solr/managed-preanalyzed: No such path /schema/fields/field2, retry? 0
[junit4] 2> 1876333 INFO (TEST-PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields-seed#[ADC7F423B7BCC7F2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAdd2Fields
[junit4] 2> 1876335 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876335 INFO (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 6 ms
[junit4] 2> 1876335 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=PreAnalyzedFieldManagedSchemaCloudTest -Dtests.method=testAdd2Fields -Dtests.seed=ADC7F423B7BCC7F2 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=nn-NO -Dtests.timezone=Africa/Nouakchott -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.12s J0 | PreAnalyzedFieldManagedSchemaCloudTest.testAdd2Fields <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:36635/solr/managed-preanalyzed, https://127.0.0.1:42686/solr/managed-preanalyzed]
[junit4] > at __randomizedtesting.SeedInfo.seed([ADC7F423B7BCC7F2:5D246C86BBA5404]: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 java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:36635/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> 1876339 INFO (Thread-3151) [n:127.0.0.1:42686_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1876340 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@833b91{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1876340 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=24021022
[junit4] 2> 1876341 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@42ce09{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 1876341 INFO (jetty-launcher-2034-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14283696
[junit4] 2> 1876342 INFO (coreCloseExecutor-6020-thread-1) [n:127.0.0.1:42686_solr c:managed-preanalyzed s:shard1 r:core_node1 x:managed-preanalyzed_shard1_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@189a594
[junit4] 2> 1876342 INFO (coreCloseExecutor-6021-thread-1) [n:127.0.0.1:36635_solr c:managed-preanalyzed s:shard2 r:core_node2 x:managed-preanalyzed_shard2_replica1] o.a.s.c.SolrCore [managed-preanalyzed_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@db595c
[junit4] 2> 1876344 INFO (jetty-launcher-2034-thread-1) [ ] o.a.s.c.Overseer Overseer (id=97031416425152518-127.0.0.1:42686_solr-n_0000000000) closing
[junit4] 2> 1876344 INFO (OverseerStateUpdate-97031416425152518-127.0.0.1:42686_solr-n_0000000000) [n:127.0.0.1:42686_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42686_solr
[junit4] 2> 1876347 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x158b98f24130005, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1876347 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x158b98f24130006, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1876348 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema [managed-preanalyzed_shard2_replica1] Schema name=managed-preanalyzed
[junit4] 2> 1876354 INFO (Thread-3150) [n:127.0.0.1:36635_solr ] o.a.s.s.IndexSchema Loaded schema managed-preanalyzed/1.6 with uniqueid field id
[junit4] 2> 1876354 WARN (Thread-3150) [n:127.0.0.1:36635_solr ] 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(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Could not load conf for core managed-preanalyzed_shard2_replica1: Unable to load reader for ConfigSet properties: configsetprops.json
[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: Unable to load reader for ConfigSet properties: configsetprops.json
[junit4] 2> at org.apache.solr.core.ConfigSetProperties.readFromResourceLoader(ConfigSetProperties.java:57)
[junit4] 2> at org.apache.solr.core.ConfigSetService.createConfigSetProperties(ConfigSetService.java:117)
[junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:79)
[junit4] 2> ... 4 more
[junit4] 2> Caused by: java.io.IOException: We re-tried 10 times but was still unable to fetch resource=configsetprops.json from ZK
[junit4] 2> at org.apache.solr.cloud.ZkSolrResourceLoader.openResource(ZkSolrResourceLoader.java:118)
[junit4] 2> at org.apache.solr.core.ConfigSetProperties.readFromResourceLoader(ConfigSetProperties.java:52)
[junit4] 2> ... 6 more
[junit4] 2> Caused by: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /configs/cloud-managed-preanalyzed/configsetprops.json
[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.exists(ZooKeeper.java:1045)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:322)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:319)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:319)
[junit4] 2> at org.apache.solr.cloud.ZkController.pathExists(ZkController.java:834)
[junit4] 2> at org.apache.solr.cloud.ZkSolrResourceLoader.openResource(ZkSolrResourceLoader.java:89)
[junit4] 2> ... 7 more
[junit4] 2> 1877846 ERROR (Thread-3151) [n:127.0.0.1:42686_solr ] 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(Thread.java:745)
[junit4] 2> 1877847 WARN (zkCallback-2045-thread-3-processing-n:127.0.0.1:42686_solr) [n:127.0.0.1:42686_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1877847 WARN (Thread-3151) [n:127.0.0.1:42686_solr ] 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(Thread.java:745)
[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> 1877847 INFO (jetty-launcher-2034-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3c9264{/solr,null,UNAVAILABLE}
[junit4] 2> 1877847 WARN (zkCallback-2044-thread-1-processing-n:127.0.0.1:36635_solr) [n:127.0.0.1:36635_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1877847 INFO (jetty-launcher-2034-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1c904de{/solr,null,UNAVAILABLE}
[junit4] 2> 1877848 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39208 39208
[junit4] 2> 1877884 INFO (Thread-3127) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39208 39208
[junit4] 2> 1877886 WARN (Thread-3127) [ ] 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> 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> 3 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/overseer/queue
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 1877886 INFO (SUITE-PreAnalyzedFieldManagedSchemaCloudTest-seed#[ADC7F423B7BCC7F2]-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/J0/temp/solr.schema.PreAnalyzedFieldManagedSchemaCloudTest_ADC7F423B7BCC7F2-001
[junit4] 2> Dec 01, 2016 8:45:20 AM 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=no): {}, locale=nn-NO, timezone=Africa/Nouakchott
[junit4] 2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 1.8.0_102 (32-bit)/cpus=12,threads=1,free=209443872,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [CdcrReplicationDistributedZkTest, EnumFieldTest, TestSolrDeletionPolicy2, ReplaceNodeTest, TestDFISimilarityFactory, SynonymTokenizerTest, DisMaxRequestHandlerTest, InfoHandlerTest, UniqFieldsUpdateProcessorFactoryTest, OutputWriterTest, OverseerRolesTest, ResourceLoaderTest, TestJoin, StatsReloadRaceTest, RollingRestartTest, TestOmitPositions, ConjunctionSolrSpellCheckerTest, DocExpirationUpdateProcessorFactoryTest, FastVectorHighlighterTest, MigrateRouteKeyTest, TestCustomSort, ReturnFieldsTest, TestOverriddenPrefixQueryForCustomFieldType, TestRandomFlRTGCloud, AlternateDirectoryTest, ConcurrentDeleteAndCreateCollectionTest, TestTolerantUpdateProcessorRandomCloud, TestConfigReload, BasicZkTest, DeleteLastCustomShardedReplicaTest, CollectionTooManyReplicasTest, TestSolrQueryParserResource, SolrRequestParserTest, PreAnalyzedUpdateProcessorTest, AsyncCallRequestStatusResponseTest, TestRangeQuery, LeaderElectionIntegrationTest, ZkNodePropsTest, ShardSplitTest, TestConfigSetsAPI, TestUseDocValuesAsStored, TestObjectReleaseTracker, TestXmlQParser, DistributedFacetExistsSmallTest, ScriptEngineTest, TestFileDictionaryLookup, TestValueSourceCache, TestCloudSchemaless, FullHLLTest, BlockCacheTest, TestHdfsUpdateLog, QueryElevationComponentTest, HdfsRestartWhileUpdatingTest, TestRealTimeGet, TestCloudInspectUtil, PeerSyncTest, TestSortByMinMaxFunction, UUIDFieldTest, ActionThrottleTest, CachingDirectoryFactoryTest, TestSmileRequest, FacetPivotSmallTest, TestLocalFSCloudBackupRestore, TestFastLRUCache, HighlighterConfigTest, SolrCoreTest, TolerantUpdateProcessorTest, TestGeoJSONResponseWriter, TestCryptoKeys, TestPerFieldSimilarity, BlockJoinFacetRandomTest, DocumentAnalysisRequestHandlerTest, DeleteShardTest, TestFieldCacheWithThreads, DistributedSpellCheckComponentTest, QueryEqualityTest, TestFoldingMultitermQuery, ExitableDirectoryReaderTest, DistribDocExpirationUpdateProcessorTest, TestDownShardTolerantSearch, TestQuerySenderNoQuery, TestJmxIntegration, TestStandardQParsers, TestReplicaProperties, TestFieldCache, TestBinaryResponseWriter, DefaultValueUpdateProcessorTest, TestInfoStreamLogging, BigEndianAscendingWordSerializerTest, TestReloadDeadlock, TestLazyCores, HdfsTlogReplayBufferedWhileIndexingTest, TestBinaryResponseWriter, TestGraphTermsQParserPlugin, TestNumericTerms64, TestStressLucene, SignatureUpdateProcessorFactoryTest, TestUnifiedSolrHighlighter, StandardRequestHandlerTest, TestDistribIDF, TestDynamicFieldCollectionResource, TestFieldResource, CreateCollectionCleanupTest, TestDistributedStatsComponentCardinality, TestSolrCoreSnapshots, TestCSVLoader, ConfigSetsAPITest, DeleteReplicaTest, DistributedQueueTest, LeaderFailureAfterFreshStartTest, LeaderInitiatedRecoveryOnShardRestartTest, MultiThreadedOCPTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, RemoteQueryErrorTest, SolrCLIZkUtilsTest, SolrXmlInZkTest, TestCloudDeleteByQuery, TestCloudRecovery, TestLeaderElectionZkExpiry, TestOnReconnectListenerSupport, TestRebalanceLeaders, HdfsChaosMonkeyNothingIsSafeTest, HdfsNNFailoverTest, HdfsSyncSliceTest, HdfsWriteToMultipleCollectionsTest, ZkStateWriterTest, TestBackupRepositoryFactory, TestConfigSetImmutable, TestConfigSetProperties, TestConfigSets, TestCorePropertiesReload, TestCustomStream, TestSolrDynamicMBean, TestSolrXml, TestSolrCloudSnapshots, TestSolrConfigHandlerConcurrent, ReplicaListTransformerTest, SpatialHeatmapFacetsTest, TestCopyFieldCollectionResource, TestDefaultSearchFieldResource, TestFieldTypeCollectionResource, TestSchemaNameResource, TestUniqueKeyFieldResource, BooleanFieldTest, ChangedSchemaMergeTest, DateRangeFieldTest, PreAnalyzedFieldManagedSchemaCloudTest]
[junit4] Completed [595/658 (1!)] on J0 in 5.45s, 1 test, 1 error <<< FAILURES!
[...truncated 53308 lines...]
[JENKINS-EA] Lucene-Solr-6.x-Linux (64bit/jdk-9-ea+140) - Build #
2313 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2313/
Java: 64bit/jdk-9-ea+140 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
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([A60419A7BBFF08A3:2CA39656341431D8]: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 11712 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_A60419A7BBFF08A3-001/init-core-data-001
[junit4] 2> 1203816 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1203818 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1203819 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-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> 1203877 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1203902 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1203978 WARN (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1203980 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1203997 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 1203999 INFO (coreLoadExecutor-8350-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> 1204060 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1204070 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1204133 WARN (coreLoadExecutor-8350-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> 1204135 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1204151 INFO (coreLoadExecutor-8350-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> 1204151 INFO (coreLoadExecutor-8350-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_A60419A7BBFF08A3-001/init-core-data-001/]
[junit4] 2> 1204151 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=69.52734375, floorSegmentMB=1.8515625, forceMergeDeletesPctAllowed=0.7902064308233514, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2557493351479492
[junit4] 2> 1204156 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1204156 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1204156 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=0.19921875, floorSegmentMB=1.5126953125, forceMergeDeletesPctAllowed=29.535938841102556, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.12572104193042338
[junit4] 2> 1204156 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@68ab62a5[collection1] main]
[junit4] 2> 1204157 WARN (coreLoadExecutor-8350-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> 1204157 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1204225 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
[junit4] 2> 1204301 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
[junit4] 2> 1204301 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
[junit4] 2> 1204301 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
[junit4] 2> 1204347 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
[junit4] 2> 1204348 INFO (coreLoadExecutor-8350-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> 1204348 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
[junit4] 2> 1204384 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
[junit4] 2> 1204523 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
[junit4] 2> 1204561 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
[junit4] 2> 1204561 INFO (coreLoadExecutor-8350-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1204561 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1204562 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1204563 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1204564 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
[junit4] 2> 1204564 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1204565 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1204565 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1204565 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1204565 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1204566 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1204566 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1204566 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1204566 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1204566 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1204566 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1204567 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1204567 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1204567 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1204568 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1204568 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1204568 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1204568 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1204568 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1204570 WARN (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 1204570 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1204571 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@526465cf[collection1] main]
[junit4] 2> 1204571 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1204572 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1204573 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1204575 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1204575 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@68ab62a5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1204575 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1204576 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1204577 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1204577 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1204577 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1204578 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1204579 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1204579 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1204581 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1204582 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1204583 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1204585 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1204586 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1204586 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@526465cf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c10)))}
[junit4] 2> 1204586 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 18
[junit4] 2> 1204587 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] 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=0
[junit4] 2> 1204587 ERROR (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] 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":0},
[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> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
[junit4] 2> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1204588 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@26f78b2b[collection1] main]
[junit4] 2> 1204589 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1204589 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1204659 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1204698 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1204785 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1204785 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1204847 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1204920 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1204989 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@26f78b2b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1204989 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 400
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency -Dtests.seed=A60419A7BBFF08A3 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-NG -Dtests.timezone=Australia/Yancowinna -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.43s J1 | SpellCheckComponentTest.testThresholdTokenFrequency <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
[junit4] > at __randomizedtesting.SeedInfo.seed([A60419A7BBFF08A3:2CA39656341431D8]: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> 1204994 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPerDictionary
[junit4] 2> 1204994 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1204995 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1204995 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1204995 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1204996 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1204996 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1204996 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1204996 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1204997 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1204997 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1204997 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1204997 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1205001 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bdb48f7[collection1] main]
[junit4] 2> 1205001 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1205001 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1205276 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1205373 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1205634 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1205635 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1205922 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1206150 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1206334 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5bdb48f7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.4.0):c10)))}
[junit4] 2> 1206334 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1336
[junit4] 2> 1206335 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] 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> 1206336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
[junit4] 2> 1206336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1206336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1206336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1206336 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1206337 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@422200f2[collection1] main]
[junit4] 2> 1206337 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1206337 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1206401 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1206474 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1206555 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1206555 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1206611 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1206674 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1206745 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@422200f2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1206746 INFO (TEST-SpellCheckComponentTest.testPerDictionary-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 409
[junit4] 2> 1206748 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaximumResultsForSuggest
[junit4] 2> 1206748 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1206749 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1206749 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1206749 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1206749 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1206750 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1206750 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1206750 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1206750 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1206751 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1206751 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1206751 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1206754 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b07d50c[collection1] main]
[junit4] 2> 1206754 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1206754 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1206860 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1206907 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1207059 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1207059 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1207180 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1207313 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1207448 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b07d50c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.4.0):c10)))}
[junit4] 2> 1207449 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 697
[junit4] 2> 1207675 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=7&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=226
[junit4] 2> 1207917 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=240
[junit4] 2> 1207917 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
[junit4] 2> expected =/spellcheck/suggestions/[1]/numFound==1
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":240},
[junit4] 2> "command":"build",
[junit4] 2> "response":{"numFound":7,"start":0,"docs":[
[junit4] 2> {
[junit4] 2> "id":4,
[junit4] 2> "range_facet_l":[4],
[junit4] 2> "range_facet_l_dv":[4],
[junit4] 2> "range_facet_i_dv":[4],
[junit4] 2> "lowerfilt":["this blue"],
[junit4] 2> "lowerfilt1and2":["this blue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":5,
[junit4] 2> "range_facet_l":[5],
[junit4] 2> "range_facet_l_dv":[5],
[junit4] 2> "range_facet_i_dv":[5],
[junit4] 2> "lowerfilt":["this blud"],
[junit4] 2> "lowerfilt1and2":["this blud"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":6,
[junit4] 2> "range_facet_l":[6],
[junit4] 2> "range_facet_l_dv":[6],
[junit4] 2> "range_facet_i_dv":[6],
[junit4] 2> "lowerfilt":["this boue"],
[junit4] 2> "lowerfilt1and2":["this boue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":7,
[junit4] 2> "range_facet_l":[7],
[junit4] 2> "range_facet_l_dv":[7],
[junit4] 2> "range_facet_i_dv":[7],
[junit4] 2> "lowerfilt":["this glue"],
[junit4] 2> "lowerfilt1and2":["this glue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":8,
[junit4] 2> "range_facet_l":[8],
[junit4] 2> "range_facet_l_dv":[8],
[junit4] 2> "range_facet_i_dv":[8],
[junit4] 2> "lowerfilt":["this blee"],
[junit4] 2> "lowerfilt1and2":["this blee"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":0,
[junit4] 2> "range_facet_l":[0],
[junit4] 2> "range_facet_l_dv":[0],
[junit4] 2> "range_facet_i_dv":[0],
[junit4] 2> "lowerfilt":["This is a title"],
[junit4] 2> "lowerfilt1and2":["This is a title"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.614Z"},
[junit4] 2> {
[junit4] 2> "id":2,
[junit4] 2> "range_facet_l":[2],
[junit4] 2> "range_facet_l_dv":[2],
[junit4] 2> "range_facet_i_dv":[2],
[junit4] 2> "lowerfilt":["This is a document"],
[junit4] 2> "lowerfilt1and2":["This is a document"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false
[junit4] 2> 1208144 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.90&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=225
[junit4] 2> 1208354 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.80&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=209
[junit4] 2> 1208354 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
[junit4] 2> expected =/spellcheck/suggestions/[1]/numFound==1
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":209},
[junit4] 2> "command":"build",
[junit4] 2> "response":{"numFound":7,"start":0,"docs":[
[junit4] 2> {
[junit4] 2> "id":4,
[junit4] 2> "range_facet_l":[4],
[junit4] 2> "range_facet_l_dv":[4],
[junit4] 2> "range_facet_i_dv":[4],
[junit4] 2> "lowerfilt":["this blue"],
[junit4] 2> "lowerfilt1and2":["this blue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":5,
[junit4] 2> "range_facet_l":[5],
[junit4] 2> "range_facet_l_dv":[5],
[junit4] 2> "range_facet_i_dv":[5],
[junit4] 2> "lowerfilt":["this blud"],
[junit4] 2> "lowerfilt1and2":["this blud"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":6,
[junit4] 2> "range_facet_l":[6],
[junit4] 2> "range_facet_l_dv":[6],
[junit4] 2> "range_facet_i_dv":[6],
[junit4] 2> "lowerfilt":["this boue"],
[junit4] 2> "lowerfilt1and2":["this boue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":7,
[junit4] 2> "range_facet_l":[7],
[junit4] 2> "range_facet_l_dv":[7],
[junit4] 2> "range_facet_i_dv":[7],
[junit4] 2> "lowerfilt":["this glue"],
[junit4] 2> "lowerfilt1and2":["this glue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":8,
[junit4] 2> "range_facet_l":[8],
[junit4] 2> "range_facet_l_dv":[8],
[junit4] 2> "range_facet_i_dv":[8],
[junit4] 2> "lowerfilt":["this blee"],
[junit4] 2> "lowerfilt1and2":["this blee"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":0,
[junit4] 2> "range_facet_l":[0],
[junit4] 2> "range_facet_l_dv":[0],
[junit4] 2> "range_facet_i_dv":[0],
[junit4] 2> "lowerfilt":["This is a title"],
[junit4] 2> "lowerfilt1and2":["This is a title"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.614Z"},
[junit4] 2> {
[junit4] 2> "id":2,
[junit4] 2> "range_facet_l":[2],
[junit4] 2> "range_facet_l_dv":[2],
[junit4] 2> "range_facet_i_dv":[2],
[junit4] 2> "lowerfilt":["This is a document"],
[junit4] 2> "lowerfilt1and2":["This is a document"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.80&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false
[junit4] 2> 1208479 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.70&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=id:[0+TO+9]&spellcheck.extendedResults=false} hits=7 status=0 QTime=124
[junit4] 2> 1208635 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false} hits=7 status=0 QTime=155
[junit4] 2> 1208636 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
[junit4] 2> expected =/spellcheck/suggestions/[1]/numFound==1
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":155},
[junit4] 2> "command":"build",
[junit4] 2> "response":{"numFound":7,"start":0,"docs":[
[junit4] 2> {
[junit4] 2> "id":4,
[junit4] 2> "range_facet_l":[4],
[junit4] 2> "range_facet_l_dv":[4],
[junit4] 2> "range_facet_i_dv":[4],
[junit4] 2> "lowerfilt":["this blue"],
[junit4] 2> "lowerfilt1and2":["this blue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":5,
[junit4] 2> "range_facet_l":[5],
[junit4] 2> "range_facet_l_dv":[5],
[junit4] 2> "range_facet_i_dv":[5],
[junit4] 2> "lowerfilt":["this blud"],
[junit4] 2> "lowerfilt1and2":["this blud"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"},
[junit4] 2> {
[junit4] 2> "id":6,
[junit4] 2> "range_facet_l":[6],
[junit4] 2> "range_facet_l_dv":[6],
[junit4] 2> "range_facet_i_dv":[6],
[junit4] 2> "lowerfilt":["this boue"],
[junit4] 2> "lowerfilt1and2":["this boue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":7,
[junit4] 2> "range_facet_l":[7],
[junit4] 2> "range_facet_l_dv":[7],
[junit4] 2> "range_facet_i_dv":[7],
[junit4] 2> "lowerfilt":["this glue"],
[junit4] 2> "lowerfilt1and2":["this glue"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":8,
[junit4] 2> "range_facet_l":[8],
[junit4] 2> "range_facet_l_dv":[8],
[junit4] 2> "range_facet_i_dv":[8],
[junit4] 2> "lowerfilt":["this blee"],
[junit4] 2> "lowerfilt1and2":["this blee"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.616Z"},
[junit4] 2> {
[junit4] 2> "id":0,
[junit4] 2> "range_facet_l":[0],
[junit4] 2> "range_facet_l_dv":[0],
[junit4] 2> "range_facet_i_dv":[0],
[junit4] 2> "lowerfilt":["This is a title"],
[junit4] 2> "lowerfilt1and2":["This is a title"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.614Z"},
[junit4] 2> {
[junit4] 2> "id":2,
[junit4] 2> "range_facet_l":[2],
[junit4] 2> "range_facet_l_dv":[2],
[junit4] 2> "range_facet_i_dv":[2],
[junit4] 2> "lowerfilt":["This is a document"],
[junit4] 2> "lowerfilt1and2":["This is a document"],
[junit4] 2> "multiDefault":["muLti-Default"],
[junit4] 2> "intDefault":42,
[junit4] 2> "timestamp":"2016-12-01T11:29:39.615Z"}]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[]}}
[junit4] 2>
[junit4] 2> request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false
[junit4] 2> 1208636 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMaximumResultsForSuggest
[junit4] 2> 1208636 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1208636 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1208636 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1208636 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1208637 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e27729e[collection1] main]
[junit4] 2> 1208637 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1208637 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1208701 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1208748 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1208812 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1208812 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1208881 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1208943 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1209003 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5e27729e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1209003 INFO (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 366
[junit4] 2> 1209004 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExtendedResultsCount
[junit4] 2> 1209005 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1209005 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1209005 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1209006 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1209006 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1209006 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1209006 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1209006 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1209007 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1209007 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1209008 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1209008 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1209009 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@61280adf[collection1] main]
[junit4] 2> 1209009 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1209009 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1209183 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1209225 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1209433 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1209433 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1209615 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1209790 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1209983 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@61280adf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.4.0):c10)))}
[junit4] 2> 1209983 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 975
[junit4] 2> 1210205 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=0 status=0 QTime=221
[junit4] 2> 1210205 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=3&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=0
[junit4] 2> 1210206 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExtendedResultsCount
[junit4] 2> 1210206 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1210206 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1210206 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1210206 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1210207 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@589e4fa6[collection1] main]
[junit4] 2> 1210207 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1210207 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1210294 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1210391 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1210471 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1210472 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1210568 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1210639 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1210719 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@589e4fa6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1210719 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 512
[junit4] 2> 1210720 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCorrectSpelling
[junit4] 2> 1210721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1210721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1210721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1210721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1210721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1210722 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1210722 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1210722 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1210722 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1210722 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1210723 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1210723 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1210725 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@71d92574[collection1] main]
[junit4] 2> 1210725 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1210725 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1210925 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1211031 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1211260 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1211260 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1211410 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1211557 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1211717 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@71d92574[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.4.0):c10)))}
[junit4] 2> 1211717 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 993
[junit4] 2> 1211718 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=0
[junit4] 2> 1211718 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=0
[junit4] 2> 1211720 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lakkle&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=1
[junit4] 2> 1211720 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCorrectSpelling
[junit4] 2> 1211720 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1211720 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1211721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1211721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1211721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7f6eccbd[collection1] main]
[junit4] 2> 1211721 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1211721 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1211789 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1211875 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1211935 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1211935 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1212650 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1212746 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1212847 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7f6eccbd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1212848 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1127
[junit4] 2> 1212849 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
[junit4] 2> 1212849 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1212850 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1212850 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1212850 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1212851 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1212851 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1212851 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1212851 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1212851 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1212852 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1212852 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1212852 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1212853 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4e8571a8[collection1] main]
[junit4] 2> 1212854 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1212854 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1213178 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1213253 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1213590 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1213590 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1213844 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1214081 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1214285 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4e8571a8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.4.0):c10)))}
[junit4] 2> 1214285 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 1432
[junit4] 2> 1214286 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
[junit4] 2> 1214286 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1214286 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1214286 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1214286 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1214287 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@518928dd[collection1] main]
[junit4] 2> 1214287 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1214287 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1214364 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1214451 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1214519 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1214519 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1214580 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1214642 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1214712 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@518928dd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1214712 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 425
[junit4] 2> 1214713 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
[junit4] 2> 1214714 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1214714 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1214714 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1214714 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1214715 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1214715 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1214715 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 1214715 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 1214715 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 1214716 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 1214716 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1214716 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1214717 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5effb4f3[collection1] main]
[junit4] 2> 1214717 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1214717 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1214890 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1214952 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1215088 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1215088 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1215204 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1215327 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1215510 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5effb4f3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.4.0):c10)))}
[junit4] 2> 1215510 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 794
[junit4] 2> 1215512 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=12346&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1215512 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
[junit4] 2> 1215512 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1215512 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1215513 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1215513 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1215513 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5ce1b639[collection1] main]
[junit4] 2> 1215513 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1215513 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1215579 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1215655 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1215708 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1215708 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1215801 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1215889 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1215983 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5ce1b639[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1215983 INFO (TEST-SpellCheckComponentTest.testNumericQuery-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 470
[junit4] 2> 1215985 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollate
[junit4] 2> 1215986 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 1215987 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 1215987 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 1215987 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 1215987 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 1215988 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 1215988 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[A60419A7BBFF08A3]) [ ] o.
[...truncated too long message...]
e=0
[junit4] 2> 1224341 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11231]} 0 0
[junit4] 2> 1224341 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1224341 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1224343 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3dec409d[collection1] main]
[junit4] 2> 1224343 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1224343 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1224591 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1224667 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1224791 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1224792 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1224943 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1225071 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1225195 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3dec409d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):c10) Uninverting(_c(6.4.0):c1)))}
[junit4] 2> 1225195 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 853
[junit4] 2> 1225196 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=855
[junit4] 2> 1225196 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
[junit4] 2> 1225196 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1225197 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0
[junit4] 2> 1225197 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1225197 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13e9f3c1
[junit4] 2> 1225197 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fbed67d[collection1] main]
[junit4] 2> 1225197 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1225197 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1225251 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1225299 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1225357 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1225357 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1225405 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1225444 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1225486 INFO (searcherExecutor-8351-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3fbed67d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1225486 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[A60419A7BBFF08A3]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 289
[junit4] 2> 1225487 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1225487 INFO (SUITE-SpellCheckComponentTest-seed#[A60419A7BBFF08A3]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=134218308
[junit4] 2> 1225487 INFO (coreCloseExecutor-8355-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2de53d06
[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_A60419A7BBFF08A3-001
[junit4] 2> NOTE: test params are: codec=Lucene62, sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=en-NG, timezone=Australia/Yancowinna
[junit4] 2> NOTE: Linux 4.4.0-47-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=170677672,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestFieldCacheReopen, TestInitParams, DistributedFacetPivotLargeTest, TestCustomDocTransformer, DistributedDebugComponentTest, TermsComponentTest, SpellingQueryConverterTest, TestSearchPerf, WordBreakSolrSpellCheckerTest, TestRawResponseWriter, ClusterStateUpdateTest, SuggestComponentContextFilterQueryTest, ClassificationUpdateProcessorFactoryTest, JsonLoaderTest, CopyFieldTest, TestExpandComponent, HdfsDirectoryFactoryTest, TestWordDelimiterFilterFactory, DistributedQueryComponentOptimizationTest, TestExclusionRuleCollectionAccess, SuggesterFSTTest, TestFreeTextSuggestions, TestSimpleTrackingShardHandler, TestRestManager, DistanceFunctionTest, RequestLoggingTest, TestHashQParserPlugin, DistributedMLTComponentTest, BasicFunctionalityTest, TestLRUCache, TestLegacyFieldCache, SortByFunctionTest, TestChildDocTransformer, TestBM25SimilarityFactory, TestFieldCacheSortRandom, TestRandomRequestDistribution, ReplicaListTransformerTest, TestQueryWrapperFilter, OverseerStatusTest, TestMissingGroups, TestLockTree, TestQueryUtils, BlockDirectoryTest, SolrCLIZkUtilsTest, DocumentBuilderTest, TestStressVersions, BadCopyFieldTest, SpellCheckCollatorTest, DistributedTermsComponentTest, HLLSerializationTest, TestSolrXml, TestPKIAuthenticationPlugin, TestAnalyzeInfixSuggestions, OverseerCollectionConfigSetProcessorTest, TlogReplayBufferedWhileIndexingTest, DistributedIntervalFacetingTest, TestSearcherReuse, URLClassifyProcessorTest, TestCloudPivotFacet, TestLMDirichletSimilarityFactory, TestDocBasedVersionConstraints, TestSolrConfigHandlerCloud, TestSlowCompositeReaderWrapper, DistributedFacetPivotSmallTest, OpenCloseCoreStressTest, DateMathParserTest, RAMDirectoryFactoryTest, UpdateRequestProcessorFactoryTest, UUIDUpdateProcessorFallbackTest, TestStressLiveNodes, DocValuesNotIndexedTest, HdfsUnloadDistributedZkTest, IndexSchemaTest, IndexBasedSpellCheckerTest, IndexSchemaRuntimeFieldTest, TestFastOutputStream, AliasIntegrationTest, BasicAuthIntegrationTest, BlockJoinFacetSimpleTest, TestCharFilters, TestQueryTypes, CSVRequestHandlerTest, TestCursorMarkWithoutUniqueKey, DocValuesTest, ConvertedLegacyTest, TestJettySolrRunner, DateRangeFieldTest, TestSerializedLuceneMatchVersion, TestConfigSetsAPIExclusivity, TestSchemaResource, TestReRankQParserPlugin, TestLeaderElectionZkExpiry, SimpleMLTQParserTest, TestFuzzyAnalyzedSuggestions, TestQuerySenderListener, TestConfigSets, SimplePostToolTest, HdfsBasicDistributedZk2Test, SearchHandlerTest, TestCollapseQParserPlugin, HdfsLockFactoryTest, TestFieldTypeCollectionResource, TestElisionMultitermQuery, TestDeleteCollectionOnDownNodes, SolrIndexSplitterTest, CdcrUpdateLogTest, ShardRoutingCustomTest, HdfsSyncSliceTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, SyncSliceTest, OverseerTest, ShardRoutingTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, ZkCLITest, TestDistributedSearch, AutoCommitTest, TestDistributedGrouping, TestFaceting, TestHashPartitioner, TermVectorComponentDistributedTest, ZkControllerTest, TestRealTimeGet, TestStressReorder, TestReload, TestCoreContainer, SpellCheckComponentTest]
[junit4] Completed [315/658 (1!)] on J1 in 21.69s, 11 tests, 1 error <<< FAILURES!
[...truncated 51113 lines...]