Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20551/
Java: 64bit/jdk-9 -XX:+UseCompressedOops -XX:+UseSerialGC --illegal-access=deny
4 tests failed.
FAILED: org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnly
Error Message:
Unexpected number of elements in the group for intGSF: 5
Stack Trace:
java.lang.AssertionError: Unexpected number of elements in the group for
intGSF: 5
at
__randomizedtesting.SeedInfo.seed([458BB7F6459065C1:DE30D9AE08C8579F]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingDVOnly(DocValuesNotIndexedTest.java:377)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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
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.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.TestCloudRecovery.corruptedLogTest
Error Message:
Timeout waiting for all live and active
Stack Trace:
java.lang.AssertionError: Timeout waiting for all live and active
at
__randomizedtesting.SeedInfo.seed([458BB7F6459065C1:C6FDE80493E96B60]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.TestCloudRecovery.corruptedLogTest(TestCloudRecovery.java:184)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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
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.base/java.lang.Thread.run(Thread.java:844)
FAILED:
org.apache.solr.cloud.TestTlogReplica.testOutOfOrderDBQWithInPlaceUpdates
Error Message:
Can not find doc 1 in http://127.0.0.1:38633/solr
Stack Trace:
java.lang.AssertionError: Can not find doc 1 in http://127.0.0.1:38633/solr
at
__randomizedtesting.SeedInfo.seed([458BB7F6459065C1:C34A4F1B1AC1B321]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:868)
at
org.apache.solr.cloud.TestTlogReplica.testOutOfOrderDBQWithInPlaceUpdates(TestTlogReplica.java:671)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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
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.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery
Error Message:
Can not find doc 3 in http://127.0.0.1:38633/solr
Stack Trace:
java.lang.AssertionError: Can not find doc 3 in http://127.0.0.1:38633/solr
at
__randomizedtesting.SeedInfo.seed([458BB7F6459065C1:847BCE5A68C0AF66]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:868)
at
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:559)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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
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.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 12561 lines...]
[junit4] Suite: org.apache.solr.cloud.DocValuesNotIndexedTest
[junit4] 2> 1509746 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/init-core-data-001
[junit4] 2> 1509746 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1509747 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1509747 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001
[junit4] 2> 1509747 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1509748 INFO (Thread-836) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1509748 INFO (Thread-836) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1509752 ERROR (Thread-836) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1509848 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:44517
[junit4] 2> 1509852 INFO (jetty-launcher-2736-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1509852 INFO (jetty-launcher-2736-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1509903 INFO (jetty-launcher-2736-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@dace0b7{/solr,null,AVAILABLE}
[junit4] 2> 1509919 INFO (jetty-launcher-2736-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7b924dc3{/solr,null,AVAILABLE}
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@8686dad{HTTP/1.1,[http/1.1]}{127.0.0.1:36743}
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.e.j.s.Server Started @1511196ms
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36743}
[junit4] 2> 1509920 ERROR (jetty-launcher-2736-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1509920 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-26T11:14:02.778758Z
[junit4] 2> 1509929 INFO (jetty-launcher-2736-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@aa78b2a{HTTP/1.1,[http/1.1]}{127.0.0.1:45953}
[junit4] 2> 1509929 INFO (jetty-launcher-2736-thread-2) [ ]
o.e.j.s.Server Started @1511205ms
[junit4] 2> 1509929 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45953}
[junit4] 2> 1509937 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1509937 ERROR (jetty-launcher-2736-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1509937 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.0.0
[junit4] 2> 1509937 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1509937 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1509937 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-26T11:14:02.795481Z
[junit4] 2> 1509940 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1509946 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44517/solr
[junit4] 2> 1509948 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44517/solr
[junit4] 2> 1510045 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1510046 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:36743_solr
[junit4] 2> 1510047 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=98725032270692357-127.0.0.1:36743_solr-n_0000000000) starting
[junit4] 2> 1510051 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36743_solr
[junit4] 2> 1510051 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1510053 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1510054 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45953_solr
[junit4] 2> 1510054 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1510055 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1510060 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1510096 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45953.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510100 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36743.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510101 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45953.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510101 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45953.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510102 INFO (jetty-launcher-2736-thread-2) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/.
[junit4] 2> 1510109 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36743.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510109 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36743.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1510110 INFO (jetty-launcher-2736-thread-1) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/.
[junit4] 2> 1510138 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1510138 INFO
(SUITE-DocValuesNotIndexedTest-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44517/solr ready
[junit4] 2> 1510141 INFO (qtp314526168-16603) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&nrtReplicas=1&action=CREATE&numShards=4&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1510142 INFO (OverseerThreadFactory-1841-thread-1) [ ]
o.a.s.c.CreateCollectionCmd Create collection dv_coll
[junit4] 2> 1510245 INFO
(OverseerStateUpdate-98725032270692357-127.0.0.1:36743_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"dv_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"dv_coll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:45953/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1510247 INFO
(OverseerStateUpdate-98725032270692357-127.0.0.1:36743_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"dv_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"dv_coll_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36743/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1510248 INFO
(OverseerStateUpdate-98725032270692357-127.0.0.1:36743_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"dv_coll",
[junit4] 2> "shard":"shard3",
[junit4] 2> "core":"dv_coll_shard3_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:45953/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1510249 INFO
(OverseerStateUpdate-98725032270692357-127.0.0.1:36743_solr-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"dv_coll",
[junit4] 2> "shard":"shard4",
[junit4] 2> "core":"dv_coll_shard4_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36743/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 1510451 INFO (qtp1353827439-16609) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1510451 INFO (qtp314526168-16605) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1510451 INFO (qtp1353827439-16609) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1510451 INFO (qtp314526168-16605) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1510451 INFO (qtp314526168-16597) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1510452 INFO (qtp1353827439-16610) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1510573 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1510573 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1511466 INFO (qtp1353827439-16610) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1511472 INFO (qtp314526168-16597) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1511476 INFO (qtp1353827439-16609) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1511500 INFO (qtp1353827439-16610) [ ] o.a.s.s.IndexSchema
[dv_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1511501 INFO (qtp1353827439-16610) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1511501 INFO (qtp1353827439-16610) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard2_replica_n2' using
configuration from collection dv_coll, trusted=true
[junit4] 2> 1511502 INFO (qtp1353827439-16610) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36743.solr.core.dv_coll.shard2.replica_n2' (registry
'solr.core.dv_coll.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1511502 INFO (qtp1353827439-16610) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1511502 INFO (qtp1353827439-16610) [ ] o.a.s.c.SolrCore
[[dv_coll_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/dv_coll_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/./dv_coll_shard2_replica_n2/data/]
[junit4] 2> 1511509 INFO (qtp1353827439-16609) [ ] o.a.s.s.IndexSchema
[dv_coll_shard4_replica_n6] Schema name=minimal
[junit4] 2> 1511510 INFO (qtp1353827439-16609) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1511510 INFO (qtp1353827439-16609) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard4_replica_n6' using
configuration from collection dv_coll, trusted=true
[junit4] 2> 1511511 INFO (qtp1353827439-16609) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36743.solr.core.dv_coll.shard4.replica_n6' (registry
'solr.core.dv_coll.shard4.replica_n6') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1511511 INFO (qtp1353827439-16609) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1511511 INFO (qtp1353827439-16609) [ ] o.a.s.c.SolrCore
[[dv_coll_shard4_replica_n6] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/dv_coll_shard4_replica_n6],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/./dv_coll_shard4_replica_n6/data/]
[junit4] 2> 1511513 INFO (qtp314526168-16597) [ ] o.a.s.s.IndexSchema
[dv_coll_shard3_replica_n4] Schema name=minimal
[junit4] 2> 1511514 INFO (qtp314526168-16597) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1511514 INFO (qtp314526168-16597) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard3_replica_n4' using
configuration from collection dv_coll, trusted=true
[junit4] 2> 1511514 INFO (qtp314526168-16597) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45953.solr.core.dv_coll.shard3.replica_n4' (registry
'solr.core.dv_coll.shard3.replica_n4') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1511515 INFO (qtp314526168-16597) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1511515 INFO (qtp314526168-16597) [ ] o.a.s.c.SolrCore
[[dv_coll_shard3_replica_n4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/dv_coll_shard3_replica_n4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/./dv_coll_shard3_replica_n4/data/]
[junit4] 2> 1511530 INFO (qtp314526168-16605) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1511534 INFO (qtp314526168-16605) [ ] o.a.s.s.IndexSchema
[dv_coll_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1511535 INFO (qtp314526168-16605) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1511535 INFO (qtp314526168-16605) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard1_replica_n1' using
configuration from collection dv_coll, trusted=true
[junit4] 2> 1511536 INFO (qtp314526168-16605) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45953.solr.core.dv_coll.shard1.replica_n1' (registry
'solr.core.dv_coll.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1511536 INFO (qtp314526168-16605) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1511536 INFO (qtp314526168-16605) [ ] o.a.s.c.SolrCore
[[dv_coll_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/dv_coll_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/./dv_coll_shard1_replica_n1/data/]
[junit4] 2> 1511601 INFO (qtp1353827439-16610) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1511601 INFO (qtp1353827439-16610) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1511602 INFO (qtp1353827439-16610) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1511602 INFO (qtp1353827439-16610) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1511604 INFO (qtp1353827439-16610) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d9b6471[dv_coll_shard2_replica_n2]
main]
[junit4] 2> 1511605 INFO (qtp314526168-16597) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1511605 INFO (qtp314526168-16597) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1511606 INFO (qtp314526168-16597) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1511606 INFO (qtp314526168-16597) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1511608 INFO (qtp314526168-16597) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@644d4287[dv_coll_shard3_replica_n4]
main]
[junit4] 2> 1511608 INFO (qtp314526168-16597) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1511608 INFO (qtp1353827439-16610) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1511608 INFO (qtp314526168-16597) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1511608 INFO (qtp314526168-16597) [ ]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 1511608 INFO (qtp1353827439-16610) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1511608 INFO (qtp1353827439-16610) [ ]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 1511609 INFO (qtp314526168-16597) [ ]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1511609 INFO (qtp314526168-16597) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1511609 INFO (qtp314526168-16597) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1579600518281428992
[junit4] 2> 1511611 INFO (qtp1353827439-16610) [ ]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1511611 INFO (qtp1353827439-16610) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1511612 INFO (searcherExecutor-1846-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@1d9b6471[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1511612 INFO (qtp1353827439-16610) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1579600518284574720
[junit4] 2> 1511612 INFO (searcherExecutor-1848-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard3_replica_n4] Registered new searcher
Searcher@644d4287[dv_coll_shard3_replica_n4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/ has no replicas
[junit4] 2> 1511613 INFO (qtp314526168-16597) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1511614 INFO (qtp314526168-16597) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/ shard3
[junit4] 2> 1511619 INFO (qtp1353827439-16609) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1511620 INFO (qtp1353827439-16609) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1511621 INFO (qtp1353827439-16609) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1511621 INFO (qtp1353827439-16609) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1511622 INFO (qtp1353827439-16609) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3f1b608b[dv_coll_shard4_replica_n6]
main]
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/ has
no replicas
[junit4] 2> 1511622 INFO (qtp1353827439-16610) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1511623 INFO (qtp1353827439-16609) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1511623 INFO (qtp1353827439-16610) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/ shard2
[junit4] 2> 1511623 INFO (qtp1353827439-16609) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1511624 INFO (qtp1353827439-16609) [ ]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 1511624 INFO (qtp1353827439-16609) [ ]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1511624 INFO (qtp1353827439-16609) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1511628 INFO (qtp314526168-16605) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1511628 INFO (qtp314526168-16605) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1511629 INFO (qtp314526168-16605) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1511629 INFO (qtp314526168-16605) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1511631 INFO (qtp314526168-16605) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5b1a024a[dv_coll_shard1_replica_n1]
main]
[junit4] 2> 1511631 INFO (searcherExecutor-1847-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard4_replica_n6] Registered new searcher
Searcher@3f1b608b[dv_coll_shard4_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1511631 INFO (qtp1353827439-16609) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1579600518304497664
[junit4] 2> 1511633 INFO (qtp314526168-16605) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1511633 INFO (qtp314526168-16605) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1511633 INFO (qtp314526168-16605) [ ]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 1511634 INFO (qtp314526168-16605) [ ]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1511634 INFO (qtp314526168-16605) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1511634 INFO (qtp314526168-16605) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1579600518307643392
[junit4] 2> 1511637 INFO (searcherExecutor-1849-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard1_replica_n1] Registered new searcher
Searcher@5b1a024a[dv_coll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/ has
no replicas
[junit4] 2> 1511644 INFO (qtp1353827439-16609) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1511647 INFO (qtp314526168-16605) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1511647 INFO (qtp314526168-16605) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1511647 INFO (qtp314526168-16605) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/
[junit4] 2> 1511647 INFO (qtp314526168-16605) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1511648 INFO (qtp314526168-16605) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/ has no replicas
[junit4] 2> 1511648 INFO (qtp314526168-16605) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1511649 INFO (qtp1353827439-16609) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/ shard4
[junit4] 2> 1511650 INFO (qtp314526168-16605) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/ shard1
[junit4] 2> 1511754 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1511754 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1511765 INFO (qtp314526168-16597) [ ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 1511766 INFO (qtp314526168-16597) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica_n4&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1315
[junit4] 2> 1511774 INFO (qtp1353827439-16610) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1511775 INFO (qtp1353827439-16610) [ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1322
[junit4] 2> 1511800 INFO (qtp1353827439-16609) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1511800 INFO (qtp314526168-16605) [ ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 1511801 INFO (qtp1353827439-16609) [ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n6&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1350
[junit4] 2> 1511801 INFO (qtp314526168-16605) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1350
[junit4] 2> 1511805 INFO (qtp314526168-16603) [ ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1511906 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1511906 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/dv_coll/state.json]
for collection [dv_coll] has occurred - updating... (live nodes size: [2])
[junit4] 2> 1512144 INFO
(OverseerCollectionConfigSetProcessor-98725032270692357-127.0.0.1:36743_solr-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1512805 INFO (qtp314526168-16603) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&nrtReplicas=1&action=CREATE&numShards=4&wt=javabin&version=2}
status=0 QTime=2663
[junit4] 2> 1512813 INFO (qtp1353827439-16598) [ ]
o.a.s.s.SchemaManager managed schema loaded . version : 0
[junit4] 2> 1512815 INFO (qtp1353827439-16598) [ ] o.a.s.s.IndexSchema
[dv_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1512816 INFO (qtp1353827439-16598) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512825 INFO (qtp1353827439-16598) [ ]
o.a.s.c.ZkController Persisted config data to node
/configs/conf1/managed-schema
[junit4] 2> 1512825 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred -
updating schema from ZooKeeper ...
[junit4] 2> 1512825 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred -
updating schema from ZooKeeper ...
[junit4] 2> 1512825 INFO (zkCallback-2747-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred -
updating schema from ZooKeeper ...
[junit4] 2> 1512826 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1512826 INFO (zkCallback-2747-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1512827 INFO (zkCallback-2748-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred -
updating schema from ZooKeeper ...
[junit4] 2> 1512828 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.s.IndexSchema [dv_coll_shard3_replica_n4] Schema name=minimal
[junit4] 2> 1512828 INFO (zkCallback-2747-thread-2) [ ]
o.a.s.s.IndexSchema [dv_coll_shard4_replica_n6] Schema name=minimal
[junit4] 2> 1512831 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512832 INFO (zkCallback-2748-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 6 ms
[junit4] 2> 1512833 INFO (zkCallback-2747-thread-2) [ ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512833 INFO (zkCallback-2747-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 7 ms
[junit4] 2> 1512833 INFO (zkCallback-2748-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1512835 INFO (zkCallback-2748-thread-2) [ ]
o.a.s.s.IndexSchema [dv_coll_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1512836 INFO (Thread-857) [ ] o.a.s.c.SolrCore config
update listener called for core dv_coll_shard1_replica_n1
[junit4] 2> 1512837 INFO (Thread-857) [ ] o.a.s.c.SolrCore core reload
dv_coll_shard1_replica_n1
[junit4] 2> 1512840 INFO (Thread-858) [ ] o.a.s.c.SolrCore config
update listener called for core dv_coll_shard2_replica_n2
[junit4] 2> 1512840 INFO (Thread-858) [ ] o.a.s.c.SolrCore core reload
dv_coll_shard2_replica_n2
[junit4] 2> 1512841 INFO (zkCallback-2748-thread-2) [ ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512841 INFO (zkCallback-2748-thread-2) [ ]
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 7 ms
[junit4] 2> 1512844 INFO (qtp1353827439-16598) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1512851 INFO (Thread-857) [ ] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 8.0.0
[junit4] 2> 1512853 INFO (qtp1353827439-16598) [ ] o.a.s.s.IndexSchema
[dv_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1512885 INFO (qtp1353827439-16598) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512885 INFO (qtp1353827439-16598) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'dv_coll_shard2_replica_n2' using
configuration from collection dv_coll
[junit4] 2> 1512891 INFO (Thread-857) [ ] o.a.s.s.IndexSchema
[dv_coll_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1512895 INFO (Thread-857) [ ] o.a.s.s.IndexSchema Loaded
schema minimal/1.1 with uniqueid field id
[junit4] 2> 1512895 INFO (Thread-857) [ ] o.a.s.c.CoreContainer
Reloading SolrCore 'dv_coll_shard1_replica_n1' using configuration from
collection dv_coll
[junit4] 2> 1512909 INFO (qtp1353827439-16598) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36743.solr.core.dv_coll.shard2.replica_n2' (registry
'solr.core.dv_coll.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1512909 INFO (qtp1353827439-16598) [ ] o.a.s.c.SolrCore
[[dv_coll_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/dv_coll_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/./dv_coll_shard2_replica_n2/data/]
[junit4] 2> 1512910 INFO (Thread-857) [ ] o.a.s.m.r.SolrJmxReporter
JMX monitoring for 'solr_45953.solr.core.dv_coll.shard1.replica_n1' (registry
'solr.core.dv_coll.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1512910 INFO (Thread-857) [ ] o.a.s.c.SolrCore
[[dv_coll_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/dv_coll_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node1/./dv_coll_shard1_replica_n1/data/]
[junit4] 2> 1512957 INFO (qtp1353827439-16598) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1512957 INFO (qtp1353827439-16598) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1512968 INFO (Thread-857) [ ] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 1512968 INFO (Thread-857) [ ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1512979 INFO (Thread-857) [ ] o.a.s.s.SolrIndexSearcher
Opening [Searcher@1374e620[dv_coll_shard1_replica_n1] main]
[junit4] 2> 1512980 INFO (qtp1353827439-16598) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2d2a9a61[dv_coll_shard2_replica_n2]
main]
[junit4] 2> 1512981 INFO (Thread-857) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1512981 INFO (Thread-857) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1512981 INFO (Thread-857) [ ] o.a.s.s.ZkIndexSchemaReader
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 1512982 INFO (Thread-857) [ ] o.a.s.s.ZkIndexSchemaReader
Current schema version 1 is already the latest
[junit4] 2> 1512982 INFO (Thread-857) [ ] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000ms.
[junit4] 2> 1512982 INFO (qtp1353827439-16598) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1512983 INFO (qtp1353827439-16598) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1512983 INFO (qtp1353827439-16598) [ ]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/conf1/managed-schema
[junit4] 2> 1512983 INFO (qtp1353827439-16598) [ ]
o.a.s.s.ZkIndexSchemaReader Current schema version 1 is already the latest
[junit4] 2> 1512984 INFO (searcherExecutor-1867-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard1_replica_n1] Registered new searcher
Searcher@1374e620[dv_coll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1512987 INFO (Thread-857) [ ] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1579600519726366720
[junit4] 2> 1512987 INFO (qtp1353827439-16598) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1512987 INFO (qtp1353827439-16598) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1579600519726366720
[junit4] 2> 1512989 INFO (Thread-857) [ ] o.a.s.u.DefaultSolrCoreState
New IndexWriter is ready to be used.
[junit4] 2> 1512990 INFO (Thread-857) [ ] o.a.s.s.SolrIndexSearcher
Opening [Searcher@6dec2d74[dv_coll_shard1_replica_n1] main]
[junit4] 2> 1512990 INFO (Thread-857) [ ] o.a.s.c.SolrCore
[dv_coll_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@193863ac
[junit4] 2> 1512990 INFO (Thread-857) [ ] o.a.s.m.SolrMetricManager
Closing metric reporters for registry=solr.core.dv_coll.shard1.replica_n1,
tag=423125932
[junit4] 2> 1512990 INFO (Thread-857) [ ] o.a.s.m.r.SolrJmxReporter
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@33a0f775:
rootName = solr_45953, domain = solr.core.dv_coll.shard1.replica_n1, service
url = null, agent id = null] for registry solr.core.dv_coll.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@71001869
[junit4] 2> 1512991 INFO (searcherExecutor-1867-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard1_replica_n1] Registered new searcher
Searcher@6dec2d74[dv_coll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1512991 INFO (searcherExecutor-1866-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@2d2a9a61[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1512995 INFO (Thread-857) [ ] o.a.s.m.SolrMetricManager
Closing metric reporters for registry=solr.collection.dv_coll.shard1.leader,
tag=423125932
[junit4] 2> 1513001 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1513001 INFO (qtp1353827439-16598) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2bd6732d[dv_coll_shard2_replica_n2]
main]
[junit4] 2> 1513002 INFO (qtp1353827439-16598) [ ]
o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 3 replicas to apply
schema update version 1 for collection dv_coll
[junit4] 2> 1513004 INFO (searcherExecutor-1866-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@2bd6732d[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513004 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
[junit4] 2> 1513006 INFO (Thread-857) [ ] o.a.s.c.SolrCore config
update listener called for core dv_coll_shard3_replica_n4
[junit4] 2> 1513006 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.s.IndexSchema [dv_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1513008 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1513009 INFO (zkCallback-2747-thread-1) [ ]
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 4 ms
[junit4] 2> 1513013 INFO (Thread-858) [ ] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 8.0.0
[junit4] 2> 1513049 INFO (Thread-858) [ ] o.a.s.s.IndexSchema
[dv_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 1513051 INFO (Thread-858) [ ] o.a.s.s.IndexSchema Loaded
schema minimal/1.1 with uniqueid field id
[junit4] 2> 1513051 INFO (Thread-858) [ ] o.a.s.c.CoreContainer
Reloading SolrCore 'dv_coll_shard2_replica_n2' using configuration from
collection dv_coll
[junit4] 2> 1513058 INFO (qtp314526168-16596) [ ] o.a.s.c.S.Request
[dv_coll_shard1_replica_n1] webapp=/solr path=/schema/zkversion
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1513058 INFO (qtp314526168-16600) [ ] o.a.s.c.S.Request
[dv_coll_shard3_replica_n4] webapp=/solr path=/schema/zkversion
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1513061 INFO (qtp1353827439-16609) [ ] o.a.s.c.S.Request
[dv_coll_shard4_replica_n6] webapp=/solr path=/schema/zkversion
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1513061 INFO (qtp1353827439-16598) [ ]
o.a.s.s.ManagedIndexSchema Took 59.0ms for 3 replicas to apply schema update
version 1 for collection dv_coll
[junit4] 2> 1513061 INFO (qtp1353827439-16598) [ ] o.a.s.c.S.Request
[dv_coll_shard2_replica_n2] webapp=/solr path=/schema
params={wt=javabin&version=2} status=0 QTime=249
[junit4] 2> 1513062 INFO (qtp1353827439-16598) [ ] o.a.s.c.SolrCore
[dv_coll_shard2_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@7e3f2e23
[junit4] 2> 1513062 INFO (qtp1353827439-16598) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.dv_coll.shard2.replica_n2, tag=2118069795
[junit4] 2> 1513062 INFO (qtp1353827439-16598) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@77f00ffb: rootName =
solr_36743, domain = solr.core.dv_coll.shard2.replica_n2, service url = null,
agent id = null] for registry solr.core.dv_coll.shard2.replica_n2 /
com.codahale.metrics.MetricRegistry@62525a53
[junit4] 2> 1513067 INFO (qtp1353827439-16598) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.dv_coll.shard2.leader, tag=2118069795
[junit4] 2> 1513077 INFO
(TEST-DocValuesNotIndexedTest.testGroupingDVOnly-seed#[458BB7F6459065C1]) [
] o.a.s.SolrTestCaseJ4 ###Starting testGroupingDVOnly
[junit4] 2> 1513083 INFO (Thread-858) [ ] o.a.s.m.r.SolrJmxReporter
JMX monitoring for 'solr_36743.solr.core.dv_coll.shard2.replica_n2' (registry
'solr.core.dv_coll.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@7655028
[junit4] 2> 1513083 INFO (Thread-858) [ ] o.a.s.c.SolrCore
[[dv_coll_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/dv_coll_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DocValuesNotIndexedTest_458BB7F6459065C1-001/tempDir-001/node2/./dv_coll_shard2_replica_n2/data/]
[junit4] 2> 1513111 INFO (qtp314526168-16596) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&wt=javabin&version=2}{deleteByQuery=*:*
(-1579600519846952960)} 0 9
[junit4] 2> 1513111 INFO (qtp1353827439-16599) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&wt=javabin&version=2}{deleteByQuery=*:*
(-1579600519824932864)} 0 30
[junit4] 2> 1513112 INFO (qtp1353827439-16609) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&wt=javabin&version=2}{deleteByQuery=*:*
(-1579600519846952960)} 0 9
[junit4] 2> 1513112 INFO (qtp314526168-16604) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica_n4] webapp=/solr
path=/update params={wt=javabin&version=2}{deleteByQuery=*:*
(-1579600519831224320)} 0 33
[junit4] 2> 1513113 INFO (qtp1353827439-16606) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519858487296,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513113 INFO (qtp1353827439-16606) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1513113 INFO (qtp314526168-16658) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519858487296,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513113 INFO (qtp314526168-16658) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1513114 INFO (qtp314526168-16656) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519859535872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513114 INFO (qtp314526168-16656) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1513122 INFO (qtp1353827439-16606) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513122 INFO (qtp1353827439-16606) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 9
[junit4] 2> 1513122 INFO (qtp314526168-16656) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6880526b[dv_coll_shard3_replica_n4]
main]
[junit4] 2> 1513122 INFO (qtp314526168-16656) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513122 INFO (qtp314526168-16658) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513122 INFO (qtp314526168-16658) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 9
[junit4] 2> 1513123 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519868973056,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513124 INFO (searcherExecutor-1848-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard3_replica_n4] Registered new searcher
Searcher@6880526b[dv_coll_shard3_replica_n4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513124 INFO (qtp314526168-16656) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica_n4] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 10
[junit4] 2> 1513124 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1513128 INFO (qtp1353827439-16598) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@978ba21[dv_coll_shard4_replica_n6]
main]
[junit4] 2> 1513129 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513130 INFO (searcherExecutor-1847-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard4_replica_n6] Registered new searcher
Searcher@978ba21[dv_coll_shard4_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513130 INFO (qtp1353827439-16598) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 6
[junit4] 2> 1513130 INFO (qtp314526168-16605) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica_n1] webapp=/solr
path=/update
params={_stateVer_=dv_coll:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 17
[junit4] 2> 1513132 INFO (Thread-858) [ ] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 1513132 INFO (Thread-858) [ ] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 1513134 INFO (Thread-858) [ ] o.a.s.s.SolrIndexSearcher
Opening [Searcher@3066b4c4[dv_coll_shard2_replica_n2] main]
[junit4] 2> 1513135 INFO (Thread-858) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1513135 INFO (Thread-858) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1513135 INFO (Thread-858) [ ] o.a.s.s.ZkIndexSchemaReader
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 1513135 INFO (Thread-858) [ ] o.a.s.s.ZkIndexSchemaReader
Current schema version 1 is already the latest
[junit4] 2> 1513136 INFO (Thread-858) [ ] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000ms.
[junit4] 2> 1513145 INFO (qtp314526168-16597) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica_n4] webapp=/solr
path=/update params={_stateVer_=dv_coll:4&wt=javabin&version=2}{add=[2
(1579600519887847424), 3 (1579600519889944576), 6 (1579600519889944577), 7
(1579600519890993152), 9 (1579600519890993153), 10010 (1579600519890993154), 18
(1579600519890993155), 10025 (1579600519890993156), 26 (1579600519890993157),
30 (1579600519890993158), ... (14 adds)]} 0 3
[junit4] 2> 1513146 INFO (qtp1353827439-16609) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica_n6] webapp=/solr
path=/update params={_stateVer_=dv_coll:4&wt=javabin&version=2}{add=[10000
(1579600519889944576), 5 (1579600519890993152), 17 (1579600519890993153), 19
(1579600519890993154), 21 (1579600519892041728), 23 (1579600519892041729), 25
(1579600519892041730), 29 (1579600519892041731), 10030 (1579600519892041732),
33 (1579600519892041733), ... (13 adds)]} 0 3
[junit4] 2> 1513148 INFO (qtp314526168-16600) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica_n1] webapp=/solr
path=/update params={_stateVer_=dv_coll:4&wt=javabin&version=2}{add=[1
(1579600519889944576), 8 (1579600519893090304), 10 (1579600519893090305), 11
(1579600519893090306), 13 (1579600519893090307), 14 (1579600519894138880),
10015 (1579600519894138881), 10020 (1579600519894138882), 24
(1579600519894138883), 27 (1579600519894138884), ... (16 adds)]} 0 5
[junit4] 2> 1513150 INFO (searcherExecutor-1875-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@3066b4c4[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513164 INFO (Thread-858) [ ] o.a.s.u.DefaultSolrCoreState
New IndexWriter is ready to be used.
[junit4] 2> 1513167 INFO (qtp1353827439-16610) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica_n2] webapp=/solr
path=/update params={_stateVer_=dv_coll:4&wt=javabin&version=2}{add=[0
(1579600519887847424), 4 (1579600519895187456), 10005 (1579600519899381760), 12
(1579600519899381761), 15 (1579600519900430336), 16 (1579600519900430337), 20
(1579600519900430338), 22 (1579600519900430339), 34 (1579600519900430340), 35
(1579600519900430341), ... (16 adds)]} 0 26
[junit4] 2> 1513168 INFO (Thread-858) [ ] o.a.s.s.SolrIndexSearcher
Opening [Searcher@7064334a[dv_coll_shard2_replica_n2] main]
[junit4] 2> 1513168 INFO (qtp1353827439-16599) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519916158976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513168 INFO (qtp314526168-16603) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519916158976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513168 INFO (Thread-858) [ ] o.a.s.c.SolrCore config
update listener called for core dv_coll_shard4_replica_n6
[junit4] 2> 1513168 INFO (qtp314526168-16604) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519916158976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513171 INFO (searcherExecutor-1875-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@7064334a[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)))}
[junit4] 2> 1513176 INFO (qtp1353827439-16599) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@62a15dc8
commitCommandVersion:1579600519916158976
[junit4] 2> 1513176 INFO (qtp314526168-16603) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6784551e
commitCommandVersion:1579600519916158976
[junit4] 2> 1513177 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1579600519925596160,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1513177 INFO (qtp1353827439-16598) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5729adfa
commitCommandVersion:1579600519925596160
[junit4] 2> 1513177 INFO (qtp314526168-16604) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5223880b
commitCommandVersion:1579600519916158976
[junit4] 2> 1513180 INFO (qtp1353827439-16598) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d7a43ca[dv_coll_shard4_replica_n6]
main]
[junit4] 2> 1513180 INFO (qtp1353827439-16598) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513182 INFO (searcherExecutor-1847-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard4_replica_n6] Registered new searcher
Searcher@1d7a43ca[dv_coll_shard4_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C13)))}
[junit4] 2> 1513182 INFO (qtp1353827439-16598) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica_n6] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 13
[junit4] 2> 1513183 INFO (qtp1353827439-16599) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@716aafad[dv_coll_shard2_replica_n2]
main]
[junit4] 2> 1513183 INFO (qtp314526168-16604) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4cd644b1[dv_coll_shard1_replica_n1]
main]
[junit4] 2> 1513183 INFO (qtp314526168-16604) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513184 INFO (searcherExecutor-1867-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard1_replica_n1] Registered new searcher
Searcher@4cd644b1[dv_coll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C16)))}
[junit4] 2> 1513184 INFO (qtp1353827439-16599) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513184 INFO (qtp314526168-16604) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 16
[junit4] 2> 1513184 INFO (qtp314526168-16603) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4068a0b9[dv_coll_shard3_replica_n4]
main]
[junit4] 2> 1513185 INFO (qtp314526168-16603) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513185 INFO (searcherExecutor-1848-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard3_replica_n4] Registered new searcher
Searcher@4068a0b9[dv_coll_shard3_replica_n4]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C14)))}
[junit4] 2> 1513186 INFO (qtp314526168-16603) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica_n4] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 17
[junit4] 2> 1513186 INFO (searcherExecutor-1866-thread-1) [ ]
o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] Registered new searcher
Searcher@716aafad[dv_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)
Uninverting(_1(8.0.0):C6)))}
[junit4] 2> 1513186 INFO (qtp1353827439-16599) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 18
[junit4] 2> 1513187 INFO (qtp1353827439-16599) [ ] o.a.s.c.SolrCore
[dv_coll_shard2_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@babf359
[junit4] 2> 1513187 INFO (qtp1353827439-16599) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.dv_coll.shard2.replica_n2, tag=195818329
[junit4] 2> 1513187 INFO (qtp1353827439-16599) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@65689727: rootName =
solr_36743, domain = solr.core.dv_coll.shard2.replica_n2, service url = null,
agent id = null] for registry solr.core.dv_coll.shard2.replica_n2 /
com.codahale.metrics.MetricRegistry@62525a53
[junit4] 2> 1513192 INFO (qtp1353827439-16599) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.dv_coll.shard2.leader, tag=195818329
[junit4] 2> 1513192 INFO (qtp314526168-16658) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica_n4] webapp=/solr
path=/update
params={_stateVer_=dv_coll:4&commit=true&wt=javabin&version=2}{commit=} 0 24
[junit4] 2> 1513199 INFO (qtp1353827439-16611) [ ] o.a.s.c.S.Request
[dv_coll_shard2_replica_n2] webapp=/solr path=/select
params={df=text&group.distributed.first=true&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/&rows=100&version=2&q=*:*&NOW=1506424446051&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=5
[junit4] 2> 1513200 INFO (qtp314526168-16605) [ ] o.a.s.c.S.Request
[dv_coll_shard1_replica_n1] webapp=/solr path=/select
params={df=text&group.distributed.first=true&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&rows=100&version=2&q=*:*&NOW=1506424446051&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=5
[junit4] 2> 1513200 INFO (qtp314526168-16597) [ ] o.a.s.c.S.Request
[dv_coll_shard3_replica_n4] webapp=/solr path=/select
params={df=text&group.distributed.first=true&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&rows=100&version=2&q=*:*&NOW=1506424446051&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=5
[junit4] 2> 1513200 INFO (qtp1353827439-16609) [ ] o.a.s.c.S.Request
[dv_coll_shard4_replica_n6] webapp=/solr path=/select
params={df=text&group.distributed.first=true&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=2048&start=0&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/&rows=100&version=2&q=*:*&NOW=1506424446051&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=6
[junit4] 2> 1513210 INFO (qtp314526168-16604) [ ] o.a.s.c.S.Request
[dv_coll_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&rows=100&version=2&group.distributed.second=true&q=*:*&NOW=1506424446051&group.topgroups.intGSF=454903010&group.topgroups.intGSF=%01&group.topgroups.intGSF=454913017&group.topgroups.intGSF=454923025&group.topgroups.intGSF=454933029&group.topgroups.intGSF=454943036&group.topgroups.intGSF=454953039&group.topgroups.intGSF=454963047&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=4
[junit4] 2> 1513210 INFO (qtp1353827439-16598) [ ] o.a.s.c.S.Request
[dv_coll_shard4_replica_n6] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/&rows=100&version=2&group.distributed.second=true&q=*:*&NOW=1506424446051&group.topgroups.intGSF=454903010&group.topgroups.intGSF=%01&group.topgroups.intGSF=454913017&group.topgroups.intGSF=454923025&group.topgroups.intGSF=454933029&group.topgroups.intGSF=454943036&group.topgroups.intGSF=454953039&group.topgroups.intGSF=454963047&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=2
[junit4] 2> 1513211 INFO (qtp1353827439-16599) [ ] o.a.s.c.S.Request
[dv_coll_shard2_replica_n2] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/&rows=100&version=2&group.distributed.second=true&q=*:*&NOW=1506424446051&group.topgroups.intGSF=454903010&group.topgroups.intGSF=%01&group.topgroups.intGSF=454913017&group.topgroups.intGSF=454923025&group.topgroups.intGSF=454933029&group.topgroups.intGSF=454943036&group.topgroups.intGSF=454953039&group.topgroups.intGSF=454963047&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=3
[junit4] 2> 1513211 INFO (qtp314526168-16600) [ ] o.a.s.c.S.Request
[dv_coll_shard3_replica_n4] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&fl=id,score&shards.purpose=4&start=0&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&rows=100&version=2&group.distributed.second=true&q=*:*&NOW=1506424446051&group.topgroups.intGSF=454903010&group.topgroups.intGSF=%01&group.topgroups.intGSF=454913017&group.topgroups.intGSF=454923025&group.topgroups.intGSF=454933029&group.topgroups.intGSF=454943036&group.topgroups.intGSF=454953039&group.topgroups.intGSF=454963047&isShard=true&wt=javabin&group.field=intGSF&group=true}
status=0 QTime=5
[junit4] 2> 1513215 INFO (qtp1353827439-16611) [ ] o.a.s.c.S.Request
[dv_coll_shard4_replica_n6] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&shards.purpose=64&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard4_replica_n6/&rows=100&version=2&q=*:*&NOW=1506424446051&ids=33,23,45,25,10040,37,17,10030,29,19,5,10000,21&isShard=true&wt=javabin&group.field=intGSF}
status=0 QTime=0
[junit4] 2> 1513216 INFO (qtp314526168-16603) [ ] o.a.s.c.S.Request
[dv_coll_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&shards.purpose=64&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard1_replica_n1/&rows=100&version=2&q=*:*&NOW=1506424446051&ids=11,13,24,14,48,27,38,10020,28,1,8,10015,40,42,10,32&isShard=true&wt=javabin&group.field=intGSF}
status=0 QTime=0
[junit4] 2> 1513224 INFO (qtp314526168-16658) [ ] o.a.s.c.S.Request
[dv_coll_shard3_replica_n4] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&shards.purpose=64&shard.url=http://127.0.0.1:45953/solr/dv_coll_shard3_replica_n4/&rows=100&version=2&q=*:*&NOW=1506424446051&ids=26,39,18,2,3,6,7,10010,9,10035,10045,10025,30,31&isShard=true&wt=javabin&group.field=intGSF}
status=0 QTime=7
[junit4] 2> 1513228 INFO (qtp1353827439-16609) [ ] o.a.s.c.S.Request
[dv_coll_shard2_replica_n2] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=dv_coll:4&group.limit=100&shards.purpose=64&shard.url=http://127.0.0.1:36743/solr/dv_coll_shard2_replica_n2/&rows=100&version=2&q=*:*&NOW=1506424446051&ids=0,22,12,34,35,4,15,16,20,10005&isShard=true&wt=javabin&group.field=intGSF}
status=0 QTime=0
[junit4] 2> 1513230 INFO (qtp1353827439-16606) [ ] o.a.s.c.S.Request
[dv_coll_shard4_replica_n6] webapp=/solr path=/select
params={q=*:*&_stateVer_=dv_coll:4&gro
[...truncated too long message...]
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 2484668 INFO (jetty-closer-3676-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6adb9e68: rootName =
solr_45753, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2d7b19ab
[junit4] 2> 2484668 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2484668 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4ebb85a3: rootName =
solr_38633, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@2d7b19ab
[junit4] 2> 2484673 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2484673 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@66d7fbbd: rootName =
solr_38633, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2f38275e
[junit4] 2> 2484673 INFO (jetty-closer-3676-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2484673 INFO (jetty-closer-3676-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@74681f0e: rootName =
solr_45753, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@2f38275e
[junit4] 2> 2484673 INFO (jetty-closer-3676-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2484674 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2484674 INFO (jetty-closer-3676-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=98725089736654871-127.0.0.1:38633_solr-n_0000000006) closing
[junit4] 2> 2484674 INFO
(OverseerStateUpdate-98725089736654871-127.0.0.1:38633_solr-n_0000000006) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:38633_solr
[junit4] 2> 2484675 INFO (zkCallback-3729-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2486175 WARN (zkCallback-3736-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2486175 WARN (zkCallback-3729-thread-3) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2486175 INFO (jetty-closer-3676-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7f6927a6{/solr,null,UNAVAILABLE}
[junit4] 2> 2486175 INFO (jetty-closer-3676-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2940d48{/solr,null,UNAVAILABLE}
[junit4] 2> 2486175 ERROR
(SUITE-TestTlogReplica-seed#[458BB7F6459065C1]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2486176 INFO
(SUITE-TestTlogReplica-seed#[458BB7F6459065C1]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:32867 32867
[junit4] 2> 2486942 INFO (Thread-2705) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:32867 32867
[junit4] 2> 2486943 WARN (Thread-2705) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/configs/conf
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 8 /solr/security.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 29
/solr/collections/tlog_replica_test_create_delete/state.json
[junit4] 2> 27
/solr/collections/tlog_replica_test_remove_leader/state.json
[junit4] 2> 23
/solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
[junit4] 2> 23
/solr/collections/tlog_replica_test_kill_tlog_replica/state.json
[junit4] 2> 22
/solr/collections/tlog_replica_test_recovery/state.json
[junit4] 2> 21
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
[junit4] 2> 21
/solr/collections/tlog_replica_test_kill_leader/state.json
[junit4] 2> 21
/solr/collections/tlog_replica_test_basic_leader_election/state.json
[junit4] 2> 15
/solr/collections/tlog_replica_test_real_time_get/state.json
[junit4] 2> 15
/solr/collections/tlog_replica_test_only_leader_indexes/state.json
[junit4] 2> 15
/solr/collections/tlog_replica_test_delete_by_id/state.json
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 6
/solr/collections/tlog_replica_test_add_docs/state.json
[junit4] 2> 5
/solr/overseer_elect/election/98725089736654853-127.0.0.1:45753_solr-n_0000000001
[junit4] 2> 3
/solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/98725089736654853-core_node2-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/collections
[junit4] 2> 3 /solr/overseer/queue
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestTlogReplica_458BB7F6459065C1-001
[junit4] 2> Sep 26, 2017 11:30:19 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {foo=FST50,
id=PostingsFormat(name=MockRandom), foo_s=FST50},
docValues:{_version_=DocValuesFormat(name=Lucene70),
id=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1509,
maxMBSortInHeap=5.776375175925529, sim=RandomSimilarity(queryNorm=false): {},
locale=uz-Arab-AF, timezone=Africa/Bissau
[junit4] 2> NOTE: Linux 4.10.0-33-generic amd64/Oracle Corporation 9
(64-bit)/cpus=8,threads=1,free=115346104,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestMissingGroups,
SolrJmxReporterTest, TestSearcherReuse, TestSortByMinMaxFunction,
TestFastOutputStream, TestWordDelimiterFilterFactory, SearchHandlerTest,
V2ApiIntegrationTest, TestSSLRandomization, TestStressLiveNodes,
TestHighFrequencyDictionaryFactory, TestComponentsName,
TestReRankQParserPlugin, TestDeleteCollectionOnDownNodes,
MoveReplicaHDFSUlogDirTest, ConfigSetsAPITest,
DocumentAnalysisRequestHandlerTest, SpellCheckCollatorTest, MetricsHandlerTest,
SolrIndexSplitterTest, SyncSliceTest, TestSolrDeletionPolicy1,
OverseerCollectionConfigSetProcessorTest, FieldMutatingUpdateProcessorTest,
TestCrossCoreJoin, TestObjectReleaseTracker, TestSizeLimitedDistributedMap,
SolrIndexConfigTest, TestIBSimilarityFactory,
CloneFieldUpdateProcessorFactoryTest, TestPKIAuthenticationPlugin,
TestPivotHelperCode, TestRetrieveFieldsOptimizer, ZkStateWriterTest,
ExplicitHLLTest, TestNumericRangeQuery64, BasicDistributedZkTest,
TestQueryWrapperFilter, ZkNodePropsTest, TestSchemaResource,
TestExclusionRuleCollectionAccess, TestRealTimeGet, TestDocSet,
SimpleMLTQParserTest, TestConfigSetsAPIExclusivity, ReplicationFactorTest,
TestBlendedInfixSuggestions, TestFieldCacheWithThreads,
IndexBasedSpellCheckerTest, HdfsNNFailoverTest, TestZkAclsWithHadoopAuth,
DocValuesNotIndexedTest, FieldAnalysisRequestHandlerTest, TestRestoreCore,
TestCSVLoader, TestStandardQParsers, XmlUpdateRequestHandlerTest,
TemplateUpdateProcessorTest, TestSolrCloudSnapshots,
ManagedSchemaRoundRobinCloudTest, TestLegacyTerms, MigrateRouteKeyTest,
CustomCollectionTest, TestBadConfig, TestSolr4Spatial, InfixSuggestersTest,
TestCloudRecovery, SolrMetricManagerTest,
PeerSyncWithIndexFingerprintCachingTest, LeaderElectionIntegrationTest,
TestOverriddenPrefixQueryForCustomFieldType, TestWriterPerf,
TestFieldTypeCollectionResource, TestSimpleTextCodec, TestRangeQuery,
TestNRTOpen, AnalyticsQueryTest, TestCloudSchemaless,
TestSolrCloudWithSecureImpersonation, TestIndexingPerformance,
TestSubQueryTransformer, TestFilteredDocIdSet, SegmentsInfoRequestHandlerTest,
ExternalFileFieldSortTest, TestTolerantUpdateProcessorRandomCloud,
TestExtendedDismaxParser, TestRemoteStreaming, TestPhraseSuggestions,
TestCloudJSONFacetJoinDomain, TestEmbeddedSolrServerAdminHandler,
TestGeoJSONResponseWriter, JvmMetricsTest, BasicZkTest, HttpPartitionTest,
TestDocTermOrds, TestDefaultStatsCache, SolrRequestParserTest,
HighlighterConfigTest, CursorPagingTest, TestLockTree, TestExceedMaxTermLength,
TestPrepRecovery, TestMergePolicyConfig, TestFieldCacheSort,
TestSerializedLuceneMatchVersion, TestExactStatsCache, SolrPluginUtilsTest,
QueryResultKeyTest, BigEndianAscendingWordDeserializerTest, RulesTest,
PeerSyncTest, SpellingQueryConverterTest, TestStressLucene,
TestReplicationHandler, TestRandomFlRTGCloud, MergeStrategyTest,
BooleanFieldTest, WordBreakSolrSpellCheckerTest, TestHighlightDedupGrouping,
TestReplicaProperties, TestRequestForwarding, TestTlogReplica]
[junit4] Completed [585/733 (3!)] on J0 in 100.60s, 13 tests, 2 failures <<<
FAILURES!
[...truncated 39982 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
