Build: https://builds.apache.org/job/Lucene-Solr-BadApples-NightlyTests-8.x/13/
2 tests failed. FAILED: org.apache.solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest.testSimple Error Message: Waiting for collection testSimple2 Timeout waiting to see state for collection=testSimple2 :DocCollection(testSimple2//collections/testSimple2/state.json/21)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node3":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node5":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n2", "shared_storage":"true", "state":"down"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node8":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Live Nodes: [127.0.0.1:33707_solr, 127.0.0.1:38945_solr] Last available state: DocCollection(testSimple2//collections/testSimple2/state.json/21)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node3":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node5":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n2", "shared_storage":"true", "state":"down"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node8":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Stack Trace: java.lang.AssertionError: Waiting for collection testSimple2 Timeout waiting to see state for collection=testSimple2 :DocCollection(testSimple2//collections/testSimple2/state.json/21)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node3":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node5":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n2", "shared_storage":"true", "state":"down"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node8":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Live Nodes: [127.0.0.1:33707_solr, 127.0.0.1:38945_solr] Last available state: DocCollection(testSimple2//collections/testSimple2/state.json/21)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node3":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node3/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node5":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n2", "shared_storage":"true", "state":"down"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:33707/solr", "node_name":"127.0.0.1:33707_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"active", "leader":"true"}, "core_node8":{ "dataDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:41884/solr", "node_name":"127.0.0.1:41884_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:34207/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} at __randomizedtesting.SeedInfo.seed([820CE93A50B573C6:BABFCDC47746A717]:0) at org.junit.Assert.fail(Assert.java:88) at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:310) at org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple(AutoAddReplicasIntegrationTest.java:169) 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:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test Error Message: Captured an uncaught exception in thread: Thread[id=140854, name=Thread-8806, state=RUNNABLE, group=TGRP-TestDistributedStatsComponentCardinality] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=140854, name=Thread-8806, state=RUNNABLE, group=TGRP-TestDistributedStatsComponentCardinality] at __randomizedtesting.SeedInfo.seed([820CE93A50B573C6:A58D6E0FE491E3E]:0) Caused by: junit.framework.AssertionFailedError: .responseHeader.status:200!=0 at __randomizedtesting.SeedInfo.seed([820CE93A50B573C6]:0) at junit.framework.Assert.fail(Assert.java:57) at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999) at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026) at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:695) Build Log: [...truncated 14014 lines...] [junit4] Suite: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/init-core-data-001 [junit4] 2> 1422592 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[820CE93A50B573C6]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 1422594 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[820CE93A50B573C6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9062) [junit4] 2> 1422594 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[820CE93A50B573C6]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1422594 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[820CE93A50B573C6]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_ws/ny [junit4] 2> 1422783 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/control/cores/collection1 [junit4] 2> 1422784 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1422785 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1422785 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1422785 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1422786 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1422786 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1422786 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1422788 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@75e913e1{/_ws/ny,null,AVAILABLE} [junit4] 2> 1422790 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@36fe24f0{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36931} [junit4] 2> 1422790 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1422854ms [junit4] 2> 1422790 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=36931, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/control/cores} [junit4] 2> 1422791 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1422791 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1422824 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1422824 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1422824 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1422824 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:41.699Z [junit4] 2> 1422824 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/control/solr.xml [junit4] 2> 1422830 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1422830 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1422831 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1423022 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1423024 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2ff7d164[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1423028 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@76ebc83a[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1423057 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1423057 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1423084 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1423099 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1423099 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1423102 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/control/cores [junit4] 2> 1423102 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1423103 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1423189 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 1423223 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1423400 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1423410 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1423410 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1423410 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 1423412 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.591778928606688] [junit4] 2> 1423501 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1423501 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1423504 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1423504 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1423505 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@4cda5b30 [junit4] 2> 1423506 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@249f9a24[collection1] main] [junit4] 2> 1423506 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1423517 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1423554 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1423555 INFO (coreLoadExecutor-12383-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630592997712199680 [junit4] 2> 1423557 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1423557 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1423557 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1423557 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1423557 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1423558 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1423558 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1423558 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1423559 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1423560 INFO (searcherExecutor-12384-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@249f9a24[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1423751 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1423752 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1423753 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1423753 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1423753 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1423754 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1423754 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1423754 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1423754 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4368ba63{/_ws/ny,null,AVAILABLE} [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7724d2b7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34794} [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1423819ms [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=34794, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard0/cores} [junit4] 2> 1423755 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1423755 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:42.630Z [junit4] 2> 1423756 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard0/solr.xml [junit4] 2> 1423761 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1423761 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1423763 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1423948 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1423950 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7a15fef9[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1423954 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@53758caf[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1423981 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1423981 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1424009 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1424027 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1424027 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1424029 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard0/cores [junit4] 2> 1424029 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1424030 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1424104 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 1424133 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1424286 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1424295 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1424296 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1424296 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 1424298 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.591778928606688] [junit4] 2> 1424377 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1424377 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1424381 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1424381 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1424383 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@734e9923 [junit4] 2> 1424383 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b594d3e[collection1] main] [junit4] 2> 1424384 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1424398 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1424443 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1424444 INFO (coreLoadExecutor-12397-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630592998644383744 [junit4] 2> 1424446 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1424446 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1424446 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1424446 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1424447 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1424447 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1424447 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1424448 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1424448 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1424449 INFO (searcherExecutor-12398-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7b594d3e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1425138 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 1425139 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1425139 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1425139 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1425139 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1425141 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1425141 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1425141 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1425141 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@741736ac{/_ws/ny,null,AVAILABLE} [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4cd28eb9{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34996} [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1425206ms [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=34996, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard1/cores} [junit4] 2> 1425142 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1425142 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:44.017Z [junit4] 2> 1425143 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard1/solr.xml [junit4] 2> 1425148 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1425148 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1425170 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1425308 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1425310 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@cc83d79[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1425315 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4b1d5296[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1425342 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1425342 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1425371 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1425389 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1425389 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1425392 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard1/cores [junit4] 2> 1425392 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1425393 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1425436 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 1425464 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1425637 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1425647 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1425647 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1425647 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 1425649 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.591778928606688] [junit4] 2> 1425728 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1425728 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1425731 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1425731 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1425732 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@76324cd5 [junit4] 2> 1425732 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@68d0fb0[collection1] main] [junit4] 2> 1425733 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1425743 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1425790 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1425790 INFO (coreLoadExecutor-12411-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630593000055767040 [junit4] 2> 1425792 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1425793 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1425793 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1425793 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1425793 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1425794 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1425794 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1425794 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1425794 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1425796 INFO (searcherExecutor-12412-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@68d0fb0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1425988 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 1425988 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1425989 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1425989 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1425989 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1425990 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1425990 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1425990 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1425991 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@535de838{/_ws/ny,null,AVAILABLE} [junit4] 2> 1425991 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@77716599{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42557} [junit4] 2> 1425991 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1426055ms [junit4] 2> 1425991 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=42557, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard2/cores} [junit4] 2> 1425992 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:44.867Z [junit4] 2> 1425992 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard2/solr.xml [junit4] 2> 1425997 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1425997 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1425999 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1426118 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1426120 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@13a50b85[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1426151 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@64c6215c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1426180 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1426180 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1426209 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1426228 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1426228 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1426231 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard2/cores [junit4] 2> 1426231 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1426232 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1426284 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 1426342 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1426506 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1426520 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1426520 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1426520 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 1426522 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.591778928606688] [junit4] 2> 1426601 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1426601 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1426604 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1426604 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1426605 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@55dfd63c [junit4] 2> 1426605 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6b7a7744[collection1] main] [junit4] 2> 1426606 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1426615 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1426656 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1426656 INFO (coreLoadExecutor-12425-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630593000963833856 [junit4] 2> 1426658 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1426658 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1426658 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1426658 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1426659 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1426659 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1426659 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1426660 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1426660 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1426661 INFO (searcherExecutor-12426-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6b7a7744[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1426839 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard3/cores/collection1 [junit4] 2> 1426839 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1426840 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1426840 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1426840 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1426841 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1426841 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1426841 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1426841 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1668371b{/_ws/ny,null,AVAILABLE} [junit4] 2> 1426842 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@158386c6{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:33647} [junit4] 2> 1426842 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1426906ms [junit4] 2> 1426842 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=33647, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard3/cores} [junit4] 2> 1426842 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1426842 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1426842 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1426843 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1426843 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1426843 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:45.718Z [junit4] 2> 1426843 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard3/solr.xml [junit4] 2> 1426848 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1426848 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1426850 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1427097 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1427099 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@283c1c3e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1427104 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7e1ce10c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1427133 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1427133 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1427169 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1427188 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1427188 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1427191 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard3/cores [junit4] 2> 1427191 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1427192 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1427260 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 1427295 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1427457 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1427467 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1427467 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@79c6ae50 [junit4] 2> 1427467 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard3/cores/collection1/data/] [junit4] 2> 1427469 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.591778928606688] [junit4] 2> 1427573 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1427573 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1427576 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1427576 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1427577 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@554650ce [junit4] 2> 1427577 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a25b694[collection1] main] [junit4] 2> 1427578 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1427591 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1427647 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1427647 INFO (coreLoadExecutor-12439-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1630593002002972672 [junit4] 2> 1427649 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1427650 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1427650 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1427650 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1427650 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1427650 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1427651 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1427651 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1427651 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1427653 INFO (searcherExecutor-12440-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a25b694[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1428347 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard4/cores/collection1 [junit4] 2> 1428348 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1428348 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1428348 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1428348 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12 [junit4] 2> 1428350 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1428350 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1428350 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1428350 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4813a026{/_ws/ny,null,AVAILABLE} [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2bb9b9d1{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:37720} [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.e.j.s.Server Started @1428414ms [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_ws/ny, hostPort=37720, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard4/cores} [junit4] 2> 1428351 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0 [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-12T07:37:47.226Z [junit4] 2> 1428351 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.handler.component.TestDistributedStatsComponentCardinality_820CE93A50B573C6-001/tempDir-001/shard4/solr.xml [junit4] 2> 1428356 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1428356 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[820CE93A50B573C6]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1428358 INFO (TEST-Te [...truncated too long message...] ler Stopped o.e.j.s.ServletContextHandler@18ef6eae{static,/static,jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE} [junit4] 2> 3691238 WARN (BP-1819109216-10.41.0.5-1555056850256 heartbeating to localhost/127.0.0.1:34207) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted [junit4] 2> 3691238 WARN (BP-1819109216-10.41.0.5-1555056850256 heartbeating to localhost/127.0.0.1:34207) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-1819109216-10.41.0.5-1555056850256 (Datanode Uuid 0a93bfcf-3827-4623-bf5e-fb1c6b111da0) service to localhost/127.0.0.1:34207 [junit4] 2> 3691250 WARN (refreshUsed-/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest_820CE93A50B573C6-001/tempDir-001/hdfsBaseDir/data/data1/current/BP-1819109216-10.41.0.5-1555056850256) [ ] o.a.h.f.CachingGetSpaceUsed Thread Interrupted waiting to refresh disk information: sleep interrupted [junit4] 2> 3691259 WARN (refreshUsed-/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest_820CE93A50B573C6-001/tempDir-001/hdfsBaseDir/data/data2/current/BP-1819109216-10.41.0.5-1555056850256) [ ] o.a.h.f.CachingGetSpaceUsed Thread Interrupted waiting to refresh disk information: sleep interrupted [junit4] 2> 3691272 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[820CE93A50B573C6]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@5e60f5c8{hdfs,/,null,UNAVAILABLE}{/hdfs} [junit4] 2> 3691273 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[820CE93A50B573C6]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@57541612{HTTP/1.1,[http/1.1]}{localhost:0} [junit4] 2> 3691273 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[820CE93A50B573C6]-worker) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 3691273 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[820CE93A50B573C6]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@13189838{static,/static,jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE} [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest_820CE93A50B573C6-001 [junit4] 2> Apr 12, 2019 8:15:30 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 33 leaked thread(s). [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@24b39d09), locale=vi, timezone=Australia/Currie [junit4] 2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation 1.8.0_191 (64-bit)/cpus=4,threads=4,free=125325416,total=483917824 [junit4] 2> NOTE: All tests run in this JVM: [CdcrVersionReplicationTest, BlobRepositoryCloudTest, TestCloudRecovery, TestInitQParser, TestSolrCloudSnapshots, NoCacheHeaderTest, DeleteStatusTest, Tagger2Test, ReturnFieldsTest, TestHalfAndHalfDocValues, UniqFieldsUpdateProcessorFactoryTest, OverriddenZkACLAndCredentialsProvidersTest, TestSolrDeletionPolicy1, SpatialHeatmapFacetsTest, TestJsonFacetsWithNestedObjects, TestReplicationHandlerBackup, TestXmlQParserPlugin, TestReRankQParserPlugin, StatsComponentTest, TestFilteredDocIdSet, TestRecoveryHdfs, TestReversedWildcardFilterFactory, TestPivotHelperCode, TestClusterProperties, SuggesterTest, HdfsRecoveryZkTest, TestRuleBasedAuthorizationPlugin, DistributedSuggestComponentTest, RootFieldTest, ZkControllerTest, OrderedExecutorTest, TestConfigOverlay, SparseHLLTest, ClusterStateTest, TestDFISimilarityFactory, DocExpirationUpdateProcessorFactoryTest, CircularListTest, TestBinaryResponseWriter, MaxSizeAutoCommitTest, TestRebalanceLeaders, TestNonDefinedSimilarityFactory, QueryEqualityTest, TestDistribIDF, RestartWhileUpdatingTest, TestSegmentSorting, PreAnalyzedFieldManagedSchemaCloudTest, TestGeoJSONResponseWriter, TestFieldCacheReopen, StatsReloadRaceTest, TestCloudSchemaless, TestFreeTextSuggestions, TestManagedSchemaThreadSafety, AssignBackwardCompatibilityTest, TestCloudConsistency, SubstringBytesRefFilterTest, TestSchemaManager, BasicAuthIntegrationTest, AutoAddReplicasIntegrationTest, TestCloudPhrasesIdentificationComponent, TestImpersonationWithHadoopAuth, TestDistribDocBasedVersion, TestSolrCoreParser, TriggerEventQueueTest, TestQuerySenderListener, ShardsWhitelistTest, IndexSchemaTest, BasicDistributedZkTest, TestSimClusterStateProvider, TestStressLiveNodes, TestRTGBase, TestManagedSynonymGraphFilterFactory, TestSolrConfigHandlerCloud, TestIndexingPerformance, PluginInfoTest, DistributedExpandComponentTest, TestPseudoReturnFields, TestDocumentBuilder, TestMultiValuedNumericRangeQuery, TestMinMaxOnMultiValuedField, ReplicaListTransformerTest, TestBlobHandler, StatelessScriptUpdateProcessorFactoryTest, SolrLogAuditLoggerPluginTest, TestSimpleTrackingShardHandler, HdfsCollectionsAPIDistributedZkTest, TestLRUStatsCache, HdfsWriteToMultipleCollectionsTest, SolrSlf4jReporterTest, TestNumericTerms32, WordBreakSolrSpellCheckerTest, TestUseDocValuesAsStored, TestExtendedDismaxParser, MoveReplicaTest, JsonLoaderTest, MetricTriggerTest, JavabinLoaderTest, SolrMetricReporterTest, TestDistributedStatsComponentCardinality, ZookeeperStatusHandlerTest, MetricsConfigTest, DistributedFacetPivotLongTailTest, SolrIndexConfigTest, SolrCoreCheckLockOnStartupTest, TestLazyCores, TestSimDistributedQueue, TestManagedResourceStorage, TestLeaderElectionZkExpiry, IgnoreLargeDocumentProcessorFactoryTest, DeleteNodeTest, HdfsBasicDistributedZk2Test, NestedShardedAtomicUpdateTest, TestScoreJoinQPScore, ConjunctionSolrSpellCheckerTest, TestObjectReleaseTracker, DistributedQueryComponentOptimizationTest, BigEndianAscendingWordSerializerTest, TestCloudNestedDocsSort, TestJoin, TestCustomSort, BooleanFieldTest, SolrPluginUtilsTest, RequestLoggingTest, HdfsChaosMonkeySafeLeaderTest, DistribJoinFromCollectionTest, CoreAdminRequestStatusTest, TestNamedUpdateProcessors, TestTrieFacet, TestBadConfig, TestLegacyFieldReuse, TestPHPSerializedResponseWriter, NodeLostTriggerIntegrationTest, TestMacros, NumericFieldsTest, XsltUpdateRequestHandlerTest, ConvertedLegacyTest, TestJsonFacetRefinement, TestSkipOverseerOperations, CollectionStateFormat2Test, TestSolrXml, CursorPagingTest, DisMaxRequestHandlerTest, DistributedIntervalFacetingTest, MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestDistributedMissingSort, TestRandomDVFaceting, TestSolrCoreProperties, TestTolerantSearch, TestTrie, ProtectedTermFilterFactoryTest, TestCharFilters, TokenizerChainTest, TestLuceneIndexBackCompat, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, ConnectionReuseTest, ActionThrottleTest, BasicZkTest, ChaosMonkeyNothingIsSafeTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, ClusterStateUpdateTest, CollectionsAPISolrJTest, ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, CreateCollectionCleanupTest, CreateRoutedAliasTest, DistribCursorPagingTest, DistributedVersionInfoTest, DocValuesNotIndexedTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, FullSolrCloudDistribCmdsTest, HttpPartitionOnCommitTest, HttpPartitionTest, LeaderFailureAfterFreshStartTest, LegacyCloudClusterPropTest, MetricsHistoryIntegrationTest, RecoveryAfterSoftCommitTest, RecoveryZkTest, RemoteQueryErrorTest, RollingRestartTest, TestStressCloudBlindAtomicUpdates, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, ZkNodePropsTest, ZkShardTermsTest, AssignTest, CollectionsAPIDistributedZkTest, HdfsAutoAddReplicasIntegrationTest] [junit4] Completed [551/853 (2!)] on J2 in 83.09s, 1 test, 1 failure <<< FAILURES! [...truncated 41564 lines...] -documentation-lint: [echo] checking for broken html... [jtidy] Checking for broken html (such as invalid tags)... [delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/lucene/build/jtidy_tmp [echo] Checking for broken links... [exec] [exec] Crawl/parse... [exec] [exec] Verify... [echo] Checking for missing docs... [exec] [exec] build/docs/join/org/apache/lucene/search/join/SeekingTermSetTermsEnum.html [exec] missing Constructors: SeekingTermSetTermsEnum-org.apache.lucene.index.TermsEnum-org.apache.lucene.util.BytesRefHash-int:A- [exec] [exec] Missing javadocs were found! BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/build.xml:661: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/build.xml:101: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/lucene/build.xml:142: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/lucene/build.xml:179: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/lucene/common-build.xml:2528: exec returned: 1 Total time: 285 minutes 41 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org