Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/150/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.LeaderElectionContextKeyTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([40ECA51D1A2CE960:C8B89AC7B4D08498]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest.test
Error Message:
Mismatch in counts between replicas
Stack Trace:
java.lang.AssertionError: Mismatch in counts between replicas
at
__randomizedtesting.SeedInfo.seed([40ECA51D1A2CE960:C8B89AC7B4D08498]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.RecoveryZkTest.assertShardConsistency(RecoveryZkTest.java:143)
at org.apache.solr.cloud.RecoveryZkTest.test(RecoveryZkTest.java:126)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11753 lines...]
[junit4] Suite: org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/init-core-data-001
[junit4] 2> 854247 WARN
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=30 numCloses=30
[junit4] 2> 854248 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 854251 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 854251 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 854252 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-001
[junit4] 2> 854252 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 854252 INFO (Thread-1749) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 854252 INFO (Thread-1749) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 854266 ERROR (Thread-1749) [ ] 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> 854352 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:50129
[junit4] 2> 854363 INFO (jetty-launcher-2786-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 854363 INFO (jetty-launcher-2786-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 854366 INFO (jetty-launcher-2786-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@55ddf5b3{/solr,null,AVAILABLE}
[junit4] 2> 854367 INFO (jetty-launcher-2786-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5fb50254{/solr,null,AVAILABLE}
[junit4] 2> 854371 INFO (jetty-launcher-2786-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@75167{HTTP/1.1,[http/1.1]}{127.0.0.1:51860}
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.e.j.s.Server Started @856638ms
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@ef66bce{HTTP/1.1,[http/1.1]}{127.0.0.1:56529}
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=51860}
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.e.j.s.Server Started @856638ms
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=56529}
[junit4] 2> 854372 ERROR (jetty-launcher-2786-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 854372 ERROR (jetty-launcher-2786-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.1.0
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-02T00:30:13.115Z
[junit4] 2> 854372 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-02T00:30:13.115Z
[junit4] 2> 854377 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 854377 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 854385 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e3ffebe050002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 854386 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e3ffebe050001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 854389 INFO (jetty-launcher-2786-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50129/solr
[junit4] 2> 854389 INFO (jetty-launcher-2786-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50129/solr
[junit4] 2> 854704 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 854705 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:56529_solr
[junit4] 2> 854707 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.c.Overseer Overseer
(id=98586605190971397-127.0.0.1:56529_solr-n_0000000000) starting
[junit4] 2> 854708 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 854709 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:51860_solr
[junit4] 2> 854712 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 854712 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 854724 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56529_solr
[junit4] 2> 854731 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 854733 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 854895 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_51860.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854903 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_51860.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854903 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_51860.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854905 INFO (jetty-launcher-2786-thread-1)
[n:127.0.0.1:51860_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-001/node2/.
[junit4] 2> 854951 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56529.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854963 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56529.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854963 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56529.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 854964 INFO (jetty-launcher-2786-thread-2)
[n:127.0.0.1:56529_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-001/node1/.
[junit4] 2> 855001 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 855002 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50129/solr ready
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 855063 WARN
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 855089 WARN
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 855094 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 855111 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs
to ./temp/Jetty_serv1.vm3_49035_hdfs____.uilln6/webapp
[junit4] 2> 855693 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Started HttpServer2$SelectChannelConnectorWithSafeStartup@serv1-vm3:49035
[junit4] 2> 855789 WARN
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 855790 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 855798 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_55260_datanode____.6zwmz1/webapp
[junit4] 2> 856275 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:55260
[junit4] 2> 856355 WARN
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 856357 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 856369 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_64977_datanode____dynz5u/webapp
[junit4] 2> 856392 ERROR (DataNode:
[[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-002/hdfsBaseDir/data/data1/,
[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-002/hdfsBaseDir/data/data2/]]
heartbeating to serv1-vm3/127.0.0.1:40042) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 856399 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x4b646f57b0cc0: from storage
DS-1bcf3777-d5cb-4139-b024-c97c83aff167 node
DatanodeRegistration(127.0.0.1:47025,
datanodeUuid=f7253191-c165-4033-9906-9e21cb03a9d2, infoPort=45588,
infoSecurePort=0, ipcPort=58792,
storageInfo=lv=-56;cid=testClusterID;nsid=1278369886;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 856400 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x4b646f57b0cc0: from storage
DS-0236ce68-13c3-4560-9b4d-c45acb382039 node
DatanodeRegistration(127.0.0.1:47025,
datanodeUuid=f7253191-c165-4033-9906-9e21cb03a9d2, infoPort=45588,
infoSecurePort=0, ipcPort=58792,
storageInfo=lv=-56;cid=testClusterID;nsid=1278369886;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 856854 INFO
(SUITE-HdfsRecoveryZkTest-seed#[40ECA51D1A2CE960]-worker) [ ] o.m.log
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:64977
[junit4] 2> 856965 ERROR (DataNode:
[[[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-002/hdfsBaseDir/data/data3/,
[DISK]file:/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-002/hdfsBaseDir/data/data4/]]
heartbeating to serv1-vm3/127.0.0.1:40042) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 856972 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x4b64717a12e36: from storage
DS-80c5a04d-d027-4a4d-ae38-31f231084bd9 node
DatanodeRegistration(127.0.0.1:44786,
datanodeUuid=3af4d8d8-135b-4093-86cf-3ba9c8941ac6, infoPort=41741,
infoSecurePort=0, ipcPort=40730,
storageInfo=lv=-56;cid=testClusterID;nsid=1278369886;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 856972 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x4b64717a12e36: from storage
DS-1e17cec3-7138-4c27-b022-eaf9ca20eb75 node
DatanodeRegistration(127.0.0.1:44786,
datanodeUuid=3af4d8d8-135b-4093-86cf-3ba9c8941ac6, infoPort=41741,
infoSecurePort=0, ipcPort=40730,
storageInfo=lv=-56;cid=testClusterID;nsid=1278369886;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 857056 INFO
(TEST-HdfsRecoveryZkTest.test-seed#[40ECA51D1A2CE960]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 857058 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&name=recoverytest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 857062 INFO
(OverseerThreadFactory-3643-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.CreateCollectionCmd Create collection
recoverytest
[junit4] 2> 857173 INFO
(OverseerStateUpdate-98586605190971397-127.0.0.1:56529_solr-n_0000000000)
[n:127.0.0.1:56529_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"recoverytest",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"recoverytest_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56529/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 857176 INFO
(OverseerStateUpdate-98586605190971397-127.0.0.1:56529_solr-n_0000000000)
[n:127.0.0.1:56529_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"recoverytest",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"recoverytest_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:51860/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 857382 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n1&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 857382 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n2&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 857382 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 857382 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 857490 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 857490 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 857490 INFO
(zkCallback-2798-thread-2-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 857491 INFO
(zkCallback-2797-thread-2-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 858393 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 858393 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 858399 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.IndexSchema [recoverytest_shard1_replica_n1] Schema name=minimal
[junit4] 2> 858399 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.IndexSchema [recoverytest_shard1_replica_n2] Schema name=minimal
[junit4] 2> 858401 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 858401 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 858401 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica_n1' using
configuration from collection recoverytest, trusted=true
[junit4] 2> 858401 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica_n2' using
configuration from collection recoverytest, trusted=true
[junit4] 2> 858401 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_51860.solr.core.recoverytest.shard1.replica_n2' (registry
'solr.core.recoverytest.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 858401 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_56529.solr.core.recoverytest.shard1.replica_n1' (registry
'solr.core.recoverytest.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c2850db
[junit4] 2> 858406 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://serv1-vm3:40042/data
[junit4] 2> 858406 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 858406 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 858406 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SolrCore [[recoverytest_shard1_replica_n2] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-001/node2/recoverytest_shard1_replica_n2],
dataDir=[hdfs://serv1-vm3:40042/data/recoverytest/core_node4/data/]
[junit4] 2> 858407 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://serv1-vm3:40042/data
[junit4] 2> 858407 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 858407 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 858407 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.SolrCore [[recoverytest_shard1_replica_n1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_40ECA51D1A2CE960-001/tempDir-001/node1/recoverytest_shard1_replica_n1],
dataDir=[hdfs://serv1-vm3:40042/data/recoverytest/core_node3/data/]
[junit4] 2> 858407 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node4/data/snapshot_metadata
[junit4] 2> 858408 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node3/data/snapshot_metadata
[junit4] 2> 858414 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 858414 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 858414 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 858415 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 858415 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 858415 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 858506 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 858507 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node4/data
[junit4] 2> 858510 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 858511 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node3/data
[junit4] 2> 858527 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node4/data/index
[junit4] 2> 858534 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 858534 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 858534 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 858538 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://serv1-vm3:40042/data/recoverytest/core_node3/data/index
[junit4] 2> 858544 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 858545 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 858545 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 858596 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 858601 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 859003 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:47025 is added to
blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-80c5a04d-d027-4a4d-ae38-31f231084bd9:NORMAL:127.0.0.1:44786|RBW],
ReplicaUC[[DISK]DS-0236ce68-13c3-4560-9b4d-c45acb382039:NORMAL:127.0.0.1:47025|RBW]]}
size 0
[junit4] 2> 859008 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44786 is added to
blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-80c5a04d-d027-4a4d-ae38-31f231084bd9:NORMAL:127.0.0.1:44786|RBW],
ReplicaUC[[DISK]DS-0236ce68-13c3-4560-9b4d-c45acb382039:NORMAL:127.0.0.1:47025|RBW]]}
size 0
[junit4] 2> 859009 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:47025 is added to
blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-1e17cec3-7138-4c27-b022-eaf9ca20eb75:NORMAL:127.0.0.1:44786|RBW],
ReplicaUC[[DISK]DS-1bcf3777-d5cb-4139-b024-c97c83aff167:NORMAL:127.0.0.1:47025|RBW]]}
size 0
[junit4] 2> 859015 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44786 is added to
blk_1073741826_1002 size 72
[junit4] 2> 859149 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 859149 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 859149 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 859166 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 859166 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 859182 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 859182 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 859182 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 859190 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@749aaac[recoverytest_shard1_replica_n2] main]
[junit4] 2> 859193 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 859193 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 859194 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 859195 INFO
(searcherExecutor-3649-thread-1-processing-n:127.0.0.1:51860_solr
x:recoverytest_shard1_replica_n2 s:shard1 c:recoverytest r:core_node4)
[n:127.0.0.1:51860_solr c:recoverytest s:shard1 r:core_node4
x:recoverytest_shard1_replica_n2] o.a.s.c.SolrCore
[recoverytest_shard1_replica_n2] Registered new searcher
Searcher@749aaac[recoverytest_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 859195 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1577385688236556288
[junit4] 2> 859199 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 859200 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 859206 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 859221 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1efd7c0a[recoverytest_shard1_replica_n1] main]
[junit4] 2> 859223 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 859224 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 859225 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 859226 INFO
(searcherExecutor-3648-thread-1-processing-n:127.0.0.1:56529_solr
x:recoverytest_shard1_replica_n1 s:shard1 c:recoverytest r:core_node3)
[n:127.0.0.1:56529_solr c:recoverytest s:shard1 r:core_node3
x:recoverytest_shard1_replica_n1] o.a.s.c.SolrCore
[recoverytest_shard1_replica_n1] Registered new searcher
Searcher@1efd7c0a[recoverytest_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 859226 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1577385688269062144
[junit4] 2> 859310 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 859310 INFO
(zkCallback-2798-thread-2-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 859310 INFO
(zkCallback-2797-thread-2-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 859311 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 859708 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 859708 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 859708 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/
[junit4] 2> 859708 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=recoverytest_shard1_replica_n2
url=http://127.0.0.1:51860/solr START
replicas=[http://127.0.0.1:56529/solr/recoverytest_shard1_replica_n1/]
nUpdates=100
[junit4] 2> 859711 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.c.S.Request [recoverytest_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 860009 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=recoverytest_shard1_replica_n2
url=http://127.0.0.1:51860/solr DONE. We have no versions. sync failed.
[junit4] 2> 860010 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 860010 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 860010 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 860015 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/ shard1
[junit4] 2> 860120 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860120 INFO
(zkCallback-2798-thread-2-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860120 INFO
(zkCallback-2797-thread-2-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860120 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860168 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 860170 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n2&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2789
[junit4] 2> 860235 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica_n1&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2853
[junit4] 2> 860238 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 860337 INFO
(zkCallback-2798-thread-1-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860337 INFO
(zkCallback-2797-thread-1-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860337 INFO
(zkCallback-2797-thread-2-processing-n:127.0.0.1:56529_solr)
[n:127.0.0.1:56529_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 860337 INFO
(zkCallback-2798-thread-2-processing-n:127.0.0.1:51860_solr)
[n:127.0.0.1:51860_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/recoverytest/state.json] for collection [recoverytest] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 861069 INFO
(OverseerCollectionConfigSetProcessor-98586605190971397-127.0.0.1:56529_solr-n_0000000000)
[n:127.0.0.1:56529_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 861239 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&name=recoverytest&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=4182
[junit4] 2> 861244 INFO
(TEST-HdfsRecoveryZkTest.test-seed#[40ECA51D1A2CE960]) [ ]
o.a.s.c.RecoveryZkTest Indexing 1350 documents
[junit4] 2> 861342 DEBUG (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.HdfsTransactionLog Opening new tlog hdfs
tlog{file=hdfs://serv1-vm3:40042/data/recoverytest/core_node4/data/tlog/tlog.0000000000000000000
refcount=1}
[junit4] 2> 861373 DEBUG (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.HdfsTransactionLog Opening new tlog hdfs
tlog{file=hdfs://serv1-vm3:40042/data/recoverytest/core_node3/data/tlog/tlog.0000000000000000000
refcount=1}
[junit4] 2> 861446 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-0
(1577385690390331392)]} 0 99
[junit4] 2> 861446 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-0
(1577385690390331392)]} 0 197
[junit4] 2> 861448 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-0
(1577385690392428544)]} 0 104
[junit4] 2> 861449 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-0
(1577385690392428544)]} 0 198
[junit4] 2> 861461 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-1
(1577385690597949440)]} 0 12
[junit4] 2> 861462 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-1
(1577385690597949440)]} 0 14
[junit4] 2> 861469 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-1
(1577385690610532352)]} 0 8
[junit4] 2> 861469 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-2
(1577385690614726656)]} 0 4
[junit4] 2> 861469 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-2
(1577385690614726656)]} 0 6
[junit4] 2> 861469 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-1
(1577385690610532352)]} 0 10
[junit4] 2> 861481 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-2
(1577385690623115264)]} 0 8
[junit4] 2> 861482 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-2
(1577385690623115264)]} 0 11
[junit4] 2> 861485 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-3
(1577385690622066688)]} 0 13
[junit4] 2> 861485 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-3
(1577385690622066688)]} 0 14
[junit4] 2> 861506 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-4
(1577385690638843904)]} 0 19
[junit4] 2> 861507 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-4
(1577385690638843904)]} 0 20
[junit4] 2> 861522 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-3
(1577385690639892480)]} 0 16
[junit4] 2> 861522 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-3
(1577385690639892480)]} 0 35
[junit4] 2> 861536 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-3
(-1577385690676592640)]} 0 13
[junit4] 2> 861536 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-3
(-1577385690676592640)]} 0 14
[junit4] 2> 861541 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-4
(1577385690677641216)]} 0 14
[junit4] 2> 861541 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-4
(1577385690677641216)]} 0 18
[junit4] 2> 861569 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-3
(-1577385690697564160)]} 0 26
[junit4] 2> 861570 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-3
(-1577385690697564160)]} 0 27
[junit4] 2> 861570 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-5
(1577385690692321280)]} 0 30
[junit4] 2> 861572 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-5
(1577385690692321280)]} 0 35
[junit4] 2> 861582 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-5
(1577385690727972864)]} 0 10
[junit4] 2> 861582 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-4
(-1577385690730070016)]} 0 8
[junit4] 2> 861583 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-5
(1577385690727972864)]} 0 11
[junit4] 2> 861583 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-4
(-1577385690730070016)]} 0 9
[junit4] 2> 861594 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-6
(1577385690742652928)]} 0 8
[junit4] 2> 861594 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-4
(-1577385690741604352)]} 0 9
[junit4] 2> 861595 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-6
(1577385690742652928)]} 0 10
[junit4] 2> 861596 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-4
(-1577385690741604352)]} 0 11
[junit4] 2> 861599 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-5
(-1577385690754187264)]} 0 2
[junit4] 2> 861600 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-5
(-1577385690754187264)]} 0 4
[junit4] 2> 861613 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-6
(1577385690755235840)]} 0 13
[junit4] 2> 861613 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-6
(1577385690755235840)]} 0 17
[junit4] 2> 861617 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-7
(1577385690772013056)]} 0 3
[junit4] 2> 861619 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-7
(1577385690772013056)]} 0 5
[junit4] 2> 861631 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-5
(-1577385690780401664)]} 0 8
[junit4] 2> 861633 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-5
(-1577385690780401664)]} 0 17
[junit4] 2> 861633 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-8
(1577385690780401665)]} 0 10
[junit4] 2> 861638 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-7
(1577385690794033152)]} 0 2
[junit4] 2> 861638 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-7
(1577385690794033152)]} 0 4
[junit4] 2> 861644 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-8
(1577385690799276032)]} 0 4
[junit4] 2> 861645 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-8
(1577385690799276032)]} 0 5
[junit4] 2> 861648 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-8
(1577385690780401665)]} 0 26
[junit4] 2> 861648 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-6
(-1577385690806616064)]} 0 1
[junit4] 2> 861648 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-6
(-1577385690806616064)]} 0 2
[junit4] 2> 861674 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-9
(1577385690808713216)]} 0 21
[junit4] 2> 861676 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-9
(1577385690808713216)]} 0 27
[junit4] 2> 861676 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-6
(-1577385690813956096)]} 0 22
[junit4] 2> 861677 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-6
(-1577385690813956096)]} 0 24
[junit4] 2> 861712 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-10
(1577385690839121920)]} 0 34
[junit4] 2> 861713 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-10
(1577385690839121920)]} 0 36
[junit4] 2> 861713 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-9
(1577385690840170496)]} 0 34
[junit4] 2> 861714 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-9
(1577385690840170496)]} 0 36
[junit4] 2> 861722 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-10
(1577385690878967808)]} 0 6
[junit4] 2> 861722 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-11
(1577385690878967809)]} 0 6
[junit4] 2> 861723 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-11
(1577385690878967809)]} 0 8
[junit4] 2> 861723 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-10
(1577385690878967808)]} 0 8
[junit4] 2> 861730 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-11
(1577385690888404992)]} 0 4
[junit4] 2> 861731 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-11
(1577385690888404992)]} 0 7
[junit4] 2> 861732 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-7
(-1577385690891550720)]} 0 3
[junit4] 2> 861732 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-7
(-1577385690891550720)]} 0 5
[junit4] 2> 861737 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-7
(-1577385690897842176)]} 0 3
[junit4] 2> 861738 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-7
(-1577385690897842176)]} 0 4
[junit4] 2> 861738 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-12
(1577385690897842177)]} 0 4
[junit4] 2> 861738 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-12
(1577385690897842177)]} 0 4
[junit4] 2> 861743 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-13
(1577385690906230784)]} 0 1
[junit4] 2> 861744 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-13
(1577385690906230784)]} 0 3
[junit4] 2> 861758 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-12
(1577385690907279360)]} 0 9
[junit4] 2> 861758 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-14
(1577385690914619392)]} 0 2
[junit4] 2> 861759 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-14
(1577385690914619392)]} 0 9
[junit4] 2> 861759 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-12
(1577385690907279360)]} 0 17
[junit4] 2> 861762 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-13
(1577385690926153728)]} 0 1
[junit4] 2> 861762 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-13
(1577385690926153728)]} 0 2
[junit4] 2> 861767 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-14
(1577385690929299456)]} 0 2
[junit4] 2> 861768 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-14
(1577385690929299456)]} 0 5
[junit4] 2> 861779 INFO (qtp196958510-10386) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-8
(-1577385690935590912)]} 0 2
[junit4] 2> 861779 INFO (qtp146017110-10375) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-8
(-1577385690935590912)]} 0 10
[junit4] 2> 861785 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-15
(1577385690947125248)]} 0 4
[junit4] 2> 861785 INFO (qtp146017110-10376) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-15
(1577385690947125248)]} 0 5
[junit4] 2> 861793 INFO (qtp196958510-10378) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-16
(1577385690953416704)]} 0 5
[junit4] 2> 861793 INFO (qtp146017110-10373) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-16
(1577385690953416704)]} 0 6
[junit4] 2> 861796 INFO (qtp196958510-10383) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[1-17
(1577385690961805312)]} 0 1
[junit4] 2> 861797 INFO (qtp146017110-10377) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[1-17
(1577385690961805312)]} 0 2
[junit4] 2> 861797 INFO (qtp196958510-10381) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[2-8
(-1577385690959708160)]} 0 3
[junit4] 2> 861797 INFO (qtp146017110-10372) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[2-8
(-1577385690959708160)]} 0 12
[junit4] 2> 861801 INFO (qtp196958510-10385) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{delete=[1-11
(-1577385690965999616)]} 0 2
[junit4] 2> 861801 INFO (qtp146017110-10370) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{delete=[1-11
(-1577385690965999616)]} 0 3
[junit4] 2> 861801 INFO (qtp196958510-10382) [n:127.0.0.1:56529_solr
c:recoverytest s:shard1 r:core_node3 x:recoverytest_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:51860/solr/recoverytest_shard1_replica_n2/&wt=javabin&version=2}{add=[2-15
(1577385690965999617)]} 0 1
[junit4] 2> 861801 INFO (qtp146017110-10374) [n:127.0.0.1:51860_solr
c:recoverytest s:shard1 r:core_node4 x:recoverytest_shard1_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [recoverytest_shard1_replica_n2]
webapp=/solr path=/update params={wt=javabin&version=2}{add=[2-15
(1577385690965999617)]} 0 3
[junit4] 2> 861804 INFO (qtp196958510-10384) [n:127.0.0.1:56529_solr c:rec
[...truncated too long message...]
limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections/testCollection2/state.json
[junit4] 2> 5 /solr/collections/testCollection1/state.json
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2> 2 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderElectionContextKeyTest_40ECA51D1A2CE960-001
[junit4] 2> Sep 02, 2017 1:00:56 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): {},
docValues:{}, maxPointsInLeafNode=1863, maxMBSortInHeap=7.6790257779842195,
sim=RandomSimilarity(queryNorm=true): {}, locale=hr-HR, timezone=GMT
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_141
(64-bit)/cpus=3,threads=1,free=231264216,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [SuggesterWFSTTest,
TestXmlQParserPlugin, ForceLeaderTest, TestCustomSort,
TestUnifiedSolrHighlighter, BinaryUpdateRequestHandlerTest, TestRTimerTree,
TestImplicitCoreProperties, TestXIncludeConfig,
OutOfBoxZkACLAndCredentialsProvidersTest, TestPointFields, RequestHandlersTest,
ConfigureRecoveryStrategyTest, DeleteNodeTest, TestCloudJSONFacetJoinDomain,
TestPHPSerializedResponseWriter, DirectUpdateHandlerOptimizeTest,
TestDistribIDF, HdfsRestartWhileUpdatingTest, TestDistributedSearch,
TestJavabinTupleStreamParser, CoreAdminHandlerTest, JvmMetricsTest,
TestSolrCloudWithKerberosAlt, WordBreakSolrSpellCheckerTest,
HardAutoCommitTest, TestSearcherReuse, TestDynamicFieldCollectionResource,
AnalysisAfterCoreReloadTest, TestSolrQueryResponse, SoftAutoCommitTest,
TestReplicaProperties, TestUtils, TestTestInjection, DocValuesTest,
JavabinLoaderTest, TestSolrConfigHandlerConcurrent, TestTolerantSearch,
CheckHdfsIndexTest, SpatialHeatmapFacetsTest, SolrSlf4jReporterTest,
TestSQLHandlerNonCloud, TestTrieFacet, RankQueryTest,
FieldAnalysisRequestHandlerTest, TestJmxIntegration, SSLMigrationTest,
TestFuzzyAnalyzedSuggestions, CreateCollectionCleanupTest,
SolrJmxReporterCloudTest, SuggesterTest, TestHighlightDedupGrouping,
SpatialFilterTest, ZkStateReaderTest, SecurityConfHandlerTest,
VMParamsZkACLAndCredentialsProvidersTest, TestLeaderElectionZkExpiry,
ResponseHeaderTest, HLLSerializationTest, DisMaxRequestHandlerTest,
TestQuerySenderNoQuery, AlternateDirectoryTest,
SpellCheckCollatorWithCollapseTest, TestPullReplicaErrorHandling, PeerSyncTest,
TestDocBasedVersionConstraints, TestStressReorder,
TestNonDefinedSimilarityFactory, ClusterStateUpdateTest, ImplicitSnitchTest,
TlogReplayBufferedWhileIndexingTest, TestReversedWildcardFilterFactory,
TestCollectionAPI, SolrCLIZkUtilsTest, DistributedFacetPivotWhiteBoxTest,
TestOmitPositions, TestFunctionQuery, AsyncCallRequestStatusResponseTest,
SyncSliceTest, TestFoldingMultitermQuery, TestCloudDeleteByQuery,
TestHalfAndHalfDocValues, TestExpandComponent, DeleteInactiveReplicaTest,
CdcrVersionReplicationTest, DistributedFacetPivotSmallAdvancedTest,
TestLegacyTerms, ReturnFieldsTest, TestFilteredDocIdSet,
TestZkAclsWithHadoopAuth, TestFieldTypeCollectionResource, VersionInfoTest,
ParsingFieldUpdateProcessorsTest, ClassificationUpdateProcessorTest,
TestTolerantUpdateProcessorCloud, DistributedExpandComponentTest,
ReplaceNodeTest, TestReplicationHandlerBackup,
TestManagedSynonymGraphFilterFactory, ResourceLoaderTest, MetricsHandlerTest,
CdcrReplicationHandlerTest, AssignBackwardCompatibilityTest, SmileWriterTest,
V2ApiIntegrationTest, HighlighterTest, TestLFUCache, ResponseLogComponentTest,
MissingSegmentRecoveryTest, TestStressCloudBlindAtomicUpdates,
TestSha256AuthenticationProvider, StatsReloadRaceTest, DateMathParserTest,
FastVectorHighlighterTest, TestDownShardTolerantSearch,
UniqFieldsUpdateProcessorFactoryTest, TestCloudPseudoReturnFields,
TestSolrCoreParser, TestBulkSchemaConcurrent, TestInitParams,
RequiredFieldsTest, DirectSolrConnectionTest,
TestEmbeddedSolrServerConstructors, TestHdfsCloudBackupRestore,
TestSweetSpotSimilarityFactory, MoveReplicaHDFSUlogDirTest, SolrCoreTest,
ShardSplitTest, HdfsLockFactoryTest, TestFaceting, CollectionReloadTest,
TestGeoJSONResponseWriter, TimeZoneUtilsTest, XmlUpdateRequestHandlerTest,
CloudMLTQParserTest, NoCacheHeaderTest, TestStressRecovery, BufferStoreTest,
DefaultValueUpdateProcessorTest, TestConfigSetsAPIZkFailure,
BigEndianAscendingWordSerializerTest, CollectionTooManyReplicasTest,
TestCollectionAPIs, GraphQueryTest, ReplicaListTransformerTest,
DistributedFacetPivotLargeTest, TestIndexingPerformance,
RAMDirectoryFactoryTest, ActionThrottleTest, HdfsBasicDistributedZk2Test,
CollectionsAPISolrJTest, TestPhraseSuggestions, BlockCacheTest,
ClassificationUpdateProcessorFactoryTest, OutputWriterTest, TestJsonFacets,
TestLegacyFieldCache, TestNoOpRegenerator, SolrInfoBeanTest,
AnalyticsQueryTest, DistribJoinFromCollectionTest, TestManagedSchemaAPI,
TestClassicSimilarityFactory, TestSolrCoreSnapshots, TestNumericRangeQuery32,
SolrXmlInZkTest, TestNumericTerms64, DistributedVersionInfoTest,
PathHierarchyTokenizerFactoryTest, TestSegmentSorting,
CoreAdminCreateDiscoverTest, MultiThreadedOCPTest, TestAddFieldRealTimeGet,
NotRequiredUniqueKeyTest, TestBackupRepositoryFactory, TestGroupingSearch,
TestHashQParserPlugin, ChaosMonkeySafeLeaderWithPullReplicasTest,
TestQuerySenderListener, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest,
CollectionsAPIDistributedZkTest, OverseerTest, ShardRoutingTest, BasicZkTest,
RecoveryZkTest, TestReplicationHandler, LeaderElectionTest,
TestRandomDVFaceting, ZkCLITest, TestDistributedGrouping, TestRecovery,
DistributedSpellCheckComponentTest, TestReload, TestRangeQuery,
SpellCheckComponentTest, QueryElevationComponentTest, BadIndexSchemaTest,
TestSort, DirectUpdateHandlerTest, TestBadConfig, SolrIndexSplitterTest,
SimplePostToolTest, SignatureUpdateProcessorFactoryTest,
TestExtendedDismaxParser, SuggesterFSTTest, TestStressLucene,
TestPseudoReturnFields, TestUpdate, TestAtomicUpdateErrorCases,
DocValuesMultiTest, DistanceFunctionTest, XsltUpdateRequestHandlerTest,
IndexBasedSpellCheckerTest, DirectSolrSpellCheckerTest, TestQueryTypes,
PrimitiveFieldTypeTest, DocumentBuilderTest, LoggingHandlerTest,
RegexBoostProcessorTest, IndexSchemaTest, TestCollationField,
TestCSVResponseWriter, QueryParsingTest, TestPartialUpdateDeduplication,
CSVRequestHandlerTest, HighlighterConfigTest, SOLR749Test, UpdateParamsTest,
TestSolrIndexConfig, BadComponentTest, TestMergePolicyConfig,
TestSolrDeletionPolicy2, MultiTermTest, TestDocSet, TestBinaryField,
NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery, TestConfig,
ExternalFileFieldSortTest, TestSolrCoreProperties, TestPostingsSolrHighlighter,
TestCharFilters, TestCodecSupport, SynonymTokenizerTest,
TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory,
TestIBSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter,
ScriptEngineTest, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest,
PluginInfoTest, ChaosMonkeyNothingIsSafeTest, BaseCdcrDistributedZkTest,
CdcrBootstrapTest, DeleteShardTest, DocValuesNotIndexedTest,
LeaderElectionContextKeyTest]
[junit4] Completed [509/731 (2!)] on J0 in 6.11s, 1 test, 1 failure <<<
FAILURES!
[...truncated 35680 lines...]
-ecj-javadoc-lint-src:
[mkdir] Created dir: /var/tmp/ecj492556829
[ecj-lint] Compiling 30 source files to /var/tmp/ecj492556829
[ecj-lint] ----------
[ecj-lint] 1. ERROR in
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/replicator/src/java/org/apache/lucene/replicator/nrt/PrimaryNode.java
(at line 33)
[ecj-lint] import org.apache.lucene.index.Term;
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] The import org.apache.lucene.index.Term is never used
[ecj-lint] ----------
[ecj-lint] 2. ERROR in
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/replicator/src/java/org/apache/lucene/replicator/nrt/PrimaryNode.java
(at line 37)
[ecj-lint] import org.apache.lucene.search.TermQuery;
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] The import org.apache.lucene.search.TermQuery is never used
[ecj-lint] ----------
[ecj-lint] ----------
[ecj-lint] 3. ERROR in
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/replicator/src/java/org/apache/lucene/replicator/nrt/ReplicaNode.java
(at line 36)
[ecj-lint] import org.apache.lucene.index.DirectoryReader;
[ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[ecj-lint] The import org.apache.lucene.index.DirectoryReader is never used
[ecj-lint] ----------
[ecj-lint] 3 problems (3 errors)
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/build.xml:810: The
following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/build.xml:101: The
following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/build.xml:208:
The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:2205:
The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:2030:
The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/lucene/common-build.xml:2069:
Compile failed; see the compiler error output for details.
Total time: 90 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
