Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/860/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseSerialGC
4 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at __randomizedtesting.SeedInfo.seed([28C3FFB0E6B889FC]:0)
at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1275)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:448)
at
org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.setupCluster(DistribDocExpirationUpdateProcessorTest.java:62)
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$6.evaluate(RandomizedRunner.java:874)
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.lucene.spatial.spatial4j.Geo3dRptTest.testOperations
{seed=[39BCAE475BCFB043:40C6F2143E9FE395]}
Error Message:
[Intersects] qIdx:3 Shouldn't match I#5:Geo3D:GeoExactCircle:
{planetmodel=PlanetModel.WGS84, center=[lat=-1.0394053553992673,
lon=-1.9037325881389144([X=-0.16538181742539926, Y=-0.4782462267840722,
Z=-0.8609141805702146])], radius=1.1546166170607672(66.15465911325472),
accuracy=4.231100485201301E-4} Q:Geo3D:GeoExactCircle:
{planetmodel=PlanetModel.WGS84, center=[lat=-1.3165961602008989,
lon=-1.887137823746273([X=-0.07807211790901268, Y=-0.23850901911945152,
Z=-0.9659034153262631])], radius=1.432516663588956(82.07715890580914),
accuracy=3.172052880854355E-11}
Stack Trace:
java.lang.AssertionError: [Intersects] qIdx:3 Shouldn't match
I#5:Geo3D:GeoExactCircle: {planetmodel=PlanetModel.WGS84,
center=[lat=-1.0394053553992673,
lon=-1.9037325881389144([X=-0.16538181742539926, Y=-0.4782462267840722,
Z=-0.8609141805702146])], radius=1.1546166170607672(66.15465911325472),
accuracy=4.231100485201301E-4} Q:Geo3D:GeoExactCircle:
{planetmodel=PlanetModel.WGS84, center=[lat=-1.3165961602008989,
lon=-1.887137823746273([X=-0.07807211790901268, Y=-0.23850901911945152,
Z=-0.9659034153262631])], radius=1.432516663588956(82.07715890580914),
accuracy=3.172052880854355E-11}
at
__randomizedtesting.SeedInfo.seed([39BCAE475BCFB043:40C6F2143E9FE395]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.fail(RandomSpatialOpStrategyTestCase.java:126)
at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.testOperation(RandomSpatialOpStrategyTestCase.java:115)
at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.testOperationRandomShapes(RandomSpatialOpStrategyTestCase.java:55)
at
org.apache.lucene.spatial.spatial4j.Geo3dRptTest.testOperations(Geo3dRptTest.java:117)
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
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
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.MigrateRouteKeyTest.multipleShardMigrateTest
Error Message:
DocCount on target collection does not match expected:<19> but was:<0>
Stack Trace:
java.lang.AssertionError: DocCount on target collection does not match
expected:<19> but was:<0>
at
__randomizedtesting.SeedInfo.seed([28C3FFB0E6B889FC:34D3E5CAC778391D]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at
org.apache.solr.cloud.MigrateRouteKeyTest.multipleShardMigrateTest(MigrateRouteKeyTest.java:144)
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.autoscaling.TriggerIntegrationTest.testNodeMarkersRegistration
Error Message:
Path /autoscaling/nodeLost/127.0.0.1:43419_solr exists
Stack Trace:
java.lang.AssertionError: Path /autoscaling/nodeLost/127.0.0.1:43419_solr exists
at
__randomizedtesting.SeedInfo.seed([28C3FFB0E6B889FC:307977BCE88D4413]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertFalse(Assert.java:68)
at
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testNodeMarkersRegistration(TriggerIntegrationTest.java:866)
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 9394 lines...]
[junit4] Suite: org.apache.lucene.spatial.spatial4j.Geo3dRptTest
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=Geo3dRptTest
-Dtests.method=testOperations -Dtests.seed=39BCAE475BCFB043
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=it-IT
-Dtests.timezone=America/Los_Angeles -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.71s J2 | Geo3dRptTest.testOperations
{seed=[39BCAE475BCFB043:40C6F2143E9FE395]} <<<
[junit4] > Throwable #1: java.lang.AssertionError: [Intersects] qIdx:3
Shouldn't match I#5:Geo3D:GeoExactCircle: {planetmodel=PlanetModel.WGS84,
center=[lat=-1.0394053553992673,
lon=-1.9037325881389144([X=-0.16538181742539926, Y=-0.4782462267840722,
Z=-0.8609141805702146])], radius=1.1546166170607672(66.15465911325472),
accuracy=4.231100485201301E-4} Q:Geo3D:GeoExactCircle:
{planetmodel=PlanetModel.WGS84, center=[lat=-1.3165961602008989,
lon=-1.887137823746273([X=-0.07807211790901268, Y=-0.23850901911945152,
Z=-0.9659034153262631])], radius=1.432516663588956(82.07715890580914),
accuracy=3.172052880854355E-11}
[junit4] > at
__randomizedtesting.SeedInfo.seed([39BCAE475BCFB043:40C6F2143E9FE395]:0)
[junit4] > at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.fail(RandomSpatialOpStrategyTestCase.java:126)
[junit4] > at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.testOperation(RandomSpatialOpStrategyTestCase.java:115)
[junit4] > at
org.apache.lucene.spatial.prefix.RandomSpatialOpStrategyTestCase.testOperationRandomShapes(RandomSpatialOpStrategyTestCase.java:55)
[junit4] > at
org.apache.lucene.spatial.spatial4j.Geo3dRptTest.testOperations(Geo3dRptTest.java:117)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are:
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=10, maxDocsPerChunk=10, blockSize=48),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=10, blockSize=48)), sim=RandomSimilarity(queryNorm=true): {},
locale=it-IT, timezone=America/Los_Angeles
[junit4] 2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=8,threads=1,free=447404576,total=518979584
[junit4] 2> NOTE: All tests run in this JVM:
[RandomSpatialOpFuzzyPrefixTreeTest, TestBBoxStrategy, Geo3dRptTest]
[junit4] Completed [23/23 (1!)] on J2 in 5.46s, 13 tests, 1 failure <<<
FAILURES!
[...truncated 2959 lines...]
[junit4] Suite: org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest
[junit4] 2> 646186 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/init-core-data-001
[junit4] 2> 646187 WARN
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=929 numCloses=929
[junit4] 2> 646187 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 646188 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 646190 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001
[junit4] 2> 646190 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 646192 INFO (Thread-2056) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 646192 INFO (Thread-2056) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 646213 ERROR (Thread-2056) [ ] 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> 646290 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.c.ZkTestServer start zk server on port:41879
[junit4] 2> 646318 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 0x15fd742f0b60000, 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> 646322 INFO (jetty-launcher-946-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 646383 INFO (jetty-launcher-946-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 646383 INFO (jetty-launcher-946-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@47cbf1e0{/solr,null,AVAILABLE}
[junit4] 2> 646388 INFO (jetty-launcher-946-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@44367908{SSL,[ssl,
http/1.1]}{127.0.0.1:45091}
[junit4] 2> 646388 INFO (jetty-launcher-946-thread-1) [ ]
o.e.j.s.Server Started @648308ms
[junit4] 2> 646388 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45091}
[junit4] 2> 646389 ERROR (jetty-launcher-946-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 646389 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 646389 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 646389 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 646389 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-20T02:30:09.527Z
[junit4] 2> 646444 INFO (jetty-launcher-946-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7faa34f6{/solr,null,AVAILABLE}
[junit4] 2> 646444 INFO (jetty-launcher-946-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@646855cc{SSL,[ssl,
http/1.1]}{127.0.0.1:44171}
[junit4] 2> 646444 INFO (jetty-launcher-946-thread-2) [ ]
o.e.j.s.Server Started @648365ms
[junit4] 2> 646444 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44171}
[junit4] 2> 646444 ERROR (jetty-launcher-946-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 646445 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 646445 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 646445 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 646445 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-20T02:30:09.583Z
[junit4] 2> 646472 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 646485 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 646504 INFO (jetty-launcher-946-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41879/solr
[junit4] 2> 646507 INFO (jetty-launcher-946-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41879/solr
[junit4] 2> 646578 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 646579 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45091_solr
[junit4] 2> 646580 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.c.Overseer Overseer
(id=99034399331713029-127.0.0.1:45091_solr-n_0000000000) starting
[junit4] 2> 646606 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 646606 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44171_solr
[junit4] 2> 646627 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45091_solr
[junit4] 2> 646627 INFO
(OverseerStateUpdate-99034399331713029-127.0.0.1:45091_solr-n_0000000000)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 646642 INFO
(zkCallback-957-thread-1-processing-n:127.0.0.1:44171_solr)
[n:127.0.0.1:44171_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 646653 INFO
(zkCallback-958-thread-2-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 646713 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45091.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646721 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45091.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646721 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45091.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646722 INFO (jetty-launcher-946-thread-1)
[n:127.0.0.1:45091_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node1/.
[junit4] 2> 646767 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44171.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646775 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44171.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646776 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44171.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 646791 INFO (jetty-launcher-946-thread-2)
[n:127.0.0.1:44171_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node2/.
[junit4] 2> 646951 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 646957 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[28C3FFB0E6B889FC]-worker)
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41879/solr
ready
[junit4] 2> 647010 INFO (qtp2030346656-6585) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
async=52a50990-72c3-4801-8104-b882dd50b775&replicationFactor=1&collection.configName=conf&name=expiry&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 647014 INFO (qtp2030346656-6585) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=52a50990-72c3-4801-8104-b882dd50b775&replicationFactor=1&collection.configName=conf&name=expiry&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=4
[junit4] 2> 647017 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 647017 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 647017 INFO
(OverseerThreadFactory-3078-thread-1-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.CreateCollectionCmd Create collection
expiry
[junit4] 2> 647128 INFO
(OverseerStateUpdate-99034399331713029-127.0.0.1:45091_solr-n_0000000000)
[n:127.0.0.1:45091_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"expiry",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"expiry_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45091/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 647129 INFO
(OverseerStateUpdate-99034399331713029-127.0.0.1:45091_solr-n_0000000000)
[n:127.0.0.1:45091_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"expiry",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"expiry_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:44171/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 647359 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=expiry&version=2&replicaType=NRT&async=52a50990-72c3-4801-8104-b882dd50b7751870358438000455&coreNodeName=core_node4&name=expiry_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin}
status=0 QTime=4
[junit4] 2> 647360 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=expiry&version=2&replicaType=NRT&async=52a50990-72c3-4801-8104-b882dd50b7751870358438000455&coreNodeName=core_node4&name=expiry_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin
[junit4] 2> 647360 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 647383 INFO (qtp1208325367-6571) [n:127.0.0.1:45091_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=expiry&version=2&replicaType=NRT&async=52a50990-72c3-4801-8104-b882dd50b7751870358436553568&coreNodeName=core_node3&name=expiry_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin}
status=0 QTime=9
[junit4] 2> 647383 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=expiry&version=2&replicaType=NRT&async=52a50990-72c3-4801-8104-b882dd50b7751870358436553568&coreNodeName=core_node3&name=expiry_shard1_replica_n1&action=CREATE&numShards=2&shard=shard1&wt=javabin
[junit4] 2> 647384 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
52a50990-72c3-4801-8104-b882dd50b7751870358436553568
[junit4] 2> 647384 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=52a50990-72c3-4801-8104-b882dd50b7751870358436553568&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 647384 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 647490 INFO
(zkCallback-957-thread-1-processing-n:127.0.0.1:44171_solr)
[n:127.0.0.1:44171_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 647490 INFO
(zkCallback-958-thread-2-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 647490 INFO
(zkCallback-958-thread-1-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 647490 INFO
(zkCallback-957-thread-2-processing-n:127.0.0.1:44171_solr)
[n:127.0.0.1:44171_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 648018 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 648019 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 648373 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 648379 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.s.IndexSchema [expiry_shard2_replica_n2]
Schema name=cloud-dynamic
[junit4] 2> 648384 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
52a50990-72c3-4801-8104-b882dd50b7751870358436553568
[junit4] 2> 648384 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=52a50990-72c3-4801-8104-b882dd50b7751870358436553568&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 648391 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
[junit4] 2> 648394 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6
with uniqueid field id
[junit4] 2> 648394 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore
'expiry_shard2_replica_n2' using configuration from collection expiry,
trusted=true
[junit4] 2> 648395 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44171.solr.core.expiry.shard2.replica_n2' (registry
'solr.core.expiry.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 648395 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 648395 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SolrCore [[expiry_shard2_replica_n2] ]
Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node2/expiry_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node2/./expiry_shard2_replica_n2/data/]
[junit4] 2> 648398 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.s.IndexSchema [expiry_shard1_replica_n1]
Schema name=cloud-dynamic
[junit4] 2> 648432 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6
with uniqueid field id
[junit4] 2> 648432 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore
'expiry_shard1_replica_n1' using configuration from collection expiry,
trusted=true
[junit4] 2> 648433 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45091.solr.core.expiry.shard1.replica_n1' (registry
'solr.core.expiry.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6c3bfe8c
[junit4] 2> 648433 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 648433 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SolrCore [[expiry_shard1_replica_n1] ]
Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node1/expiry_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_28C3FFB0E6B889FC-001/tempDir-001/node1/./expiry_shard1_replica_n1/data/]
[junit4] 2> 648473 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 648473 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 648473 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 648473 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 648474 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 648474 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 648474 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 648474 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 648476 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@84e37b3[expiry_shard1_replica_n1] main]
[junit4] 2> 648476 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7c055404[expiry_shard2_replica_n2] main]
[junit4] 2> 648476 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 648476 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 648476 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 648477 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 648485 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved
for 10000ms.
[junit4] 2> 648485 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved
for 10000ms.
[junit4] 2> 648485 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in
index or recent updates, using new clock 1584550391707598848
[junit4] 2> 648486 INFO
(searcherExecutor-3084-thread-1-processing-x:expiry_shard1_replica_n1
r:core_node3 52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE
n:127.0.0.1:45091_solr s:shard1 c:expiry) [n:127.0.0.1:45091_solr c:expiry
s:shard1 r:core_node3 x:expiry_shard1_replica_n1] o.a.s.c.SolrCore
[expiry_shard1_replica_n1] Registered new searcher
Searcher@84e37b3[expiry_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 648486 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in
index or recent updates, using new clock 1584550391708647424
[junit4] 2> 648487 INFO
(searcherExecutor-3083-thread-1-processing-x:expiry_shard2_replica_n2
r:core_node4 52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE
n:127.0.0.1:44171_solr s:shard2 c:expiry) [n:127.0.0.1:44171_solr c:expiry
s:shard2 r:core_node4 x:expiry_shard2_replica_n2] o.a.s.c.SolrCore
[expiry_shard2_replica_n2] Registered new searcher
Searcher@7c055404[expiry_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 648489 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 648489 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 648489 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/ has no replicas
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:44171/solr/expiry_shard2_replica_n2/
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.SyncStrategy
https://127.0.0.1:44171/solr/expiry_shard2_replica_n2/ has no replicas
[junit4] 2> 648490 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 648497 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/ shard1
[junit4] 2> 648498 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new
leader: https://127.0.0.1:44171/solr/expiry_shard2_replica_n2/ shard2
[junit4] 2> 648599 INFO
(zkCallback-957-thread-1-processing-n:127.0.0.1:44171_solr)
[n:127.0.0.1:44171_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 648599 INFO
(zkCallback-957-thread-2-processing-n:127.0.0.1:44171_solr)
[n:127.0.0.1:44171_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 648599 INFO
(zkCallback-958-thread-2-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 648599 INFO
(zkCallback-958-thread-1-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/expiry/state.json] for collection [expiry] has occurred -
updating... (live nodes size: [2])
[junit4] 2> 648648 INFO
(parallelCoreAdminExecutor-3079-thread-1-processing-n:127.0.0.1:45091_solr
52a50990-72c3-4801-8104-b882dd50b7751870358436553568 CREATE)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 648648 INFO
(parallelCoreAdminExecutor-3080-thread-1-processing-n:127.0.0.1:44171_solr
52a50990-72c3-4801-8104-b882dd50b7751870358438000455 CREATE)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 649019 INFO (qtp2030346656-6585) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 649020 INFO (qtp2030346656-6585) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 649385 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
52a50990-72c3-4801-8104-b882dd50b7751870358436553568
[junit4] 2> 649385 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=52a50990-72c3-4801-8104-b882dd50b7751870358436553568&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 649387 INFO (qtp2030346656-6580) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
52a50990-72c3-4801-8104-b882dd50b7751870358438000455
[junit4] 2> 649387 INFO (qtp2030346656-6580) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=52a50990-72c3-4801-8104-b882dd50b7751870358438000455&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 649389 INFO
(OverseerThreadFactory-3078-thread-1-processing-n:127.0.0.1:45091_solr)
[n:127.0.0.1:45091_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> 650021 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 650021 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=52a50990-72c3-4801-8104-b882dd50b775&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 650022 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with
params
requestid=52a50990-72c3-4801-8104-b882dd50b775&action=DELETESTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 650022 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=52a50990-72c3-4801-8104-b882dd50b775&action=DELETESTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 651017 INFO
(OverseerCollectionConfigSetProcessor-99034399331713029-127.0.0.1:45091_solr-n_0000000000)
[n:127.0.0.1:45091_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> 651485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 651487 INFO (autoExpireDocs-3093-thread-1)
[n:127.0.0.1:44171_solr c:expiry s:shard2 r:core_node4
x:expiry_shard2_replica_n2] o.a.s.u.p.DocExpirationUpdateProcessorFactory Not
currently in charge of periodic deletes for this collection, will not trigger
delete or log again until this changes
[junit4] 2> 651507 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:14.623Z] (-1584550394868006912)} 0 8
[junit4] 2> 651517 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550394886881280,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 651517 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 651519 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 2
[junit4] 2> 651528 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550394898415616,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 651528 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 651528 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 651536 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:14.623Z] (-1584550394863812608),commit=} 0 51
[junit4] 2> 651537 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 654485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 654490 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:17.623Z] (-1584550398001152000)} 0 3
[junit4] 2> 654492 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550398006394880,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 654492 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 654496 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 4
[junit4] 2> 654497 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550398011637760,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 654498 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 654498 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 654498 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:17.623Z] (-1584550398000103424),commit=} 0 13
[junit4] 2> 654498 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 657485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 657487 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:20.623Z] (-1584550401145831424)} 0 0
[junit4] 2> 657488 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550401147928576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 657489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 657489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 657490 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550401150025728,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 657491 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 657491 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 657492 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:20.623Z] (-1584550401144782848),commit=} 0 6
[junit4] 2> 657492 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 660485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 660486 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:23.623Z] (-1584550404291559424)} 0 0
[junit4] 2> 660488 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550404293656576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 660488 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550404293656576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 660488 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 660488 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 660488 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 660488 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 660488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:23.623Z] (-1584550404290510848),commit=} 0 3
[junit4] 2> 660488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 663485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 663487 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:26.623Z] (-1584550407437287424)} 0 0
[junit4] 2> 663488 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550407439384576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 663488 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 663489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550407440433152,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 663489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 663489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 663489 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 663490 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:26.623Z] (-1584550407436238848),commit=} 0 5
[junit4] 2> 663490 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 666485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 666487 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:29.623Z] (-1584550410583015424)} 0 0
[junit4] 2> 666488 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550410585112576,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 666489 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550410586161152,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 666489 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 666489 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 666500 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 666500 INFO (qtp1208325367-6572) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 11
[junit4] 2> 666500 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:29.623Z] (-1584550410581966848),commit=} 0 15
[junit4] 2> 666500 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 669485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 669487 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:32.623Z] (-1584550413728743424)} 0 0
[junit4] 2> 669489 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550413731889152,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 669489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550413731889152,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 669489 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 669489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 669489 INFO (qtp1208325367-6575) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 669489 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 669489 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:32.623Z] (-1584550413727694848),commit=} 0 4
[junit4] 2> 669490 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 672485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 672486 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:35.623Z] (-1584550416874471424)} 0 0
[junit4] 2> 672487 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550416875520000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 672487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550416875520000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 672487 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 672487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 672487 INFO (qtp1208325367-6576) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 672487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 672488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:35.623Z] (-1584550416873422848),commit=} 0 2
[junit4] 2> 672488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 675485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 675486 INFO (qtp2030346656-6579) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:38.623Z] (-1584550420020199424)} 0 0
[junit4] 2> 675487 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550420021248000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 675487 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550420021248000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 675487 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 675487 INFO (qtp2030346656-6587) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 675487 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 675487 INFO (qtp1208325367-6577) [n:127.0.0.1:45091_solr
c:expiry s:shard1 r:core_node3 x:expiry_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard1_replica_n1] webapp=/solr
path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=true&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 675488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory
[expiry_shard1_replica_n1] {deleteByQuery={!cache=false}eXpField_tdt:[* TO
2017-11-20T02:30:38.623Z] (-1584550420019150848),commit=} 0 2
[junit4] 2> 675488 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Finished periodic deletion of expired docs
[junit4] 2> 678485 INFO (autoExpireDocs-3094-thread-1)
[n:127.0.0.1:45091_solr c:expiry s:shard1 r:core_node3
x:expiry_shard1_replica_n1] o.a.s.u.p.DocExpirationUpdateProcessorFactory
Beginning periodic deletion of expired docs
[junit4] 2> 678486 INFO (qtp2030346656-6584) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.p.LogUpdateProcessorFactory [expiry_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45091/solr/expiry_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery={!cache=false}eXpField_tdt:[*
TO 2017-11-20T02:30:41.623Z] (-1584550423165927424)} 0 0
[junit4] 2> 678487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1584550423166976000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 678487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171_solr
c:expiry s:shard2 r:core_node4 x:expiry_shard2_replica_n2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 678487 INFO (qtp2030346656-6581) [n:127.0.0.1:44171
[...truncated too long message...]
try=solr.core.migrate_multipleshardtest_targetCollection.shard1.replica_n1,
tag=13208622
[junit4] 2> 3578460 INFO (coreCloseExecutor-9703-thread-2)
[n:127.0.0.1:37113_solr c:migrate_multipleshardtest_targetCollection s:shard1
r:core_node2 x:migrate_multipleshardtest_targetCollection_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@121a3c28: rootName =
solr_37113, domain =
solr.core.migrate_multipleshardtest_targetCollection.shard1.replica_n1, service
url = null, agent id = null] for registry
solr.core.migrate_multipleshardtest_targetCollection.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@328ac2a
[junit4] 2> 3578465 INFO (coreCloseExecutor-9703-thread-2)
[n:127.0.0.1:37113_solr c:migrate_multipleshardtest_targetCollection s:shard1
r:core_node2 x:migrate_multipleshardtest_targetCollection_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.migrate_multipleshardtest_targetCollection.shard1.leader,
tag=13208622
[junit4] 2> 3578465 INFO (coreCloseExecutor-9703-thread-1)
[n:127.0.0.1:37113_solr c:sourceCollection s:shard2 r:core_node4
x:sourceCollection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.sourceCollection.shard2.leader,
tag=345956981
[junit4] 2> 3578465 INFO (coreCloseExecutor-9703-thread-3)
[n:127.0.0.1:37113_solr c:split_shard2_temp_shard1 s:shard1 r:core_node2
x:split_shard2_temp_shard1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.split_shard2_temp_shard1.shard1.leader, tag=2020488779
[junit4] 2> 3578466 INFO (jetty-closer-3724-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@522b134e{/solr,null,UNAVAILABLE}
[junit4] 2> 3578466 ERROR
(SUITE-MigrateRouteKeyTest-seed#[28C3FFB0E6B889FC]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 3578466 INFO
(SUITE-MigrateRouteKeyTest-seed#[28C3FFB0E6B889FC]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:45633 45633
[junit4] 2> 3583873 INFO (Thread-5729) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:45633 45633
[junit4] 2> 3583874 WARN (Thread-5729) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 2
/solr/collections/split_shard2_temp_shard1/state.json
[junit4] 2> 2 /solr/security.json
[junit4] 2> 2 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/collections/sourceCollection/state.json
[junit4] 2> 5
/solr/collections/migrate_multipleshardtest_targetCollection/state.json
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.MigrateRouteKeyTest_28C3FFB0E6B889FC-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{n_ti=PostingsFormat(name=Asserting), id=PostingsFormat(name=Memory)},
docValues:{}, maxPointsInLeafNode=1999, maxMBSortInHeap=6.639449167468564,
sim=RandomSimilarity(queryNorm=true): {}, locale=de-GR,
timezone=Australia/Broken_Hill
[junit4] 2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=8,threads=1,free=59818848,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [ExecutePlanActionTest,
DistributedSpellCheckComponentTest, TestSolrConfigHandlerCloud,
TestLRUStatsCache, QueryElevationComponentTest, EchoParamsTest, RankQueryTest,
TestManagedSchemaAPI, TestClassicSimilarityFactory,
WordBreakSolrSpellCheckerTest, TestMaxTokenLenTokenizer, TestSolrCLIRunExample,
PluginInfoTest, CopyFieldTest, TestStressUserVersions,
PKIAuthenticationIntegrationTest, QueryResultKeyTest,
TestDistribDocBasedVersion, MetricUtilsTest, HighlighterTest, StressHdfsTest,
TestFiltering, SubstringBytesRefFilterTest, TestPayloadCheckQParserPlugin,
CachingDirectoryFactoryTest, TestUseDocValuesAsStored2,
DisMaxRequestHandlerTest, TestCloudPivotFacet, SuggesterWFSTTest,
AliasIntegrationTest, LeaderElectionTest, CheckHdfsIndexTest,
TestNumericRangeQuery32, NodeMutatorTest, HdfsRestartWhileUpdatingTest,
TestSchemaManager, DistanceFunctionTest, BlockJoinFacetSimpleTest,
CollectionsAPIAsyncDistributedZkTest, MoveReplicaHDFSTest,
TestCollapseQParserPlugin, NodeAddedTriggerTest, TestZkChroot,
DocValuesNotIndexedTest, TestHdfsBackupRestoreCore,
TestSlowCompositeReaderWrapper, ConnectionReuseTest, TestHashPartitioner,
SolrCoreMetricManagerTest, CSVRequestHandlerTest, TestManagedResourceStorage,
IndexSchemaTest, SearchHandlerTest, ZkStateWriterTest,
TestSkipOverseerOperations, LeaderElectionContextKeyTest,
TestMinMaxOnMultiValuedField, RecoveryAfterSoftCommitTest,
SolrJmxReporterCloudTest, AlternateDirectoryTest, TestTrie,
ClassificationUpdateProcessorIntegrationTest, TestGraphMLResponseWriter,
CursorMarkTest, TestRawResponseWriter, BJQParserTest, HttpSolrCallGetCoreTest,
TestLegacyNumericRangeQueryBuilder, TestSimpleTextCodec,
TestExtendedDismaxParser, HdfsNNFailoverTest, V2ApiIntegrationTest,
TestEmbeddedSolrServerConstructors, UpdateLogTest, DeleteStatusTest,
TestQuerySenderListener, CdcrReplicationDistributedZkTest,
TestSolrCoreProperties, ConfigSetsAPITest, TestCoreContainer,
FacetPivotSmallTest, TestSearchPerf, BadComponentTest,
TestRuleBasedAuthorizationPlugin, TestMiniSolrCloudClusterSSL,
StatsComponentTest, TestNamedUpdateProcessors, DeleteNodeTest, TestPullReplica,
TestCorePropertiesReload, TestNRTOpen, ChaosMonkeyNothingIsSafeTest,
TestSegmentSorting, TestRealTimeGet, TestUniqueKeyFieldResource,
JSONWriterTest, AsyncCallRequestStatusResponseTest, RecoveryZkTest,
UnloadDistributedZkTest, SystemInfoHandlerTest, TestRestoreCore,
TestElisionMultitermQuery, TestStreamBody, TestGroupingSearch,
TestFileDictionaryLookup, DirectSolrConnectionTest,
SpellCheckCollatorWithCollapseTest, TestDistributedGrouping,
SolrMetricsIntegrationTest, SolrCoreCheckLockOnStartupTest,
TestXmlQParserPlugin, TestCollectionsAPIViaSolrCloudCluster,
TestCollationFieldDocValues, HLLSerializationTest,
SharedFSAutoReplicaFailoverTest, DistributedQueryComponentCustomSortTest,
UUIDUpdateProcessorFallbackTest, ReplicationFactorTest,
SecurityConfHandlerTest, TimeZoneUtilsTest, JavabinLoaderTest,
CoreAdminCreateDiscoverTest, ChaosMonkeySafeLeaderTest,
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, OverseerTest,
ShardRoutingTest, FullSolrCloudDistribCmdsTest, ShardRoutingCustomTest,
TestFaceting, TestRecovery, TestJoin, TestReload, TestStressVersions,
TestRangeQuery, BadIndexSchemaTest, DirectUpdateHandlerTest, TestIndexSearcher,
DistributedQueryElevationComponentTest, SimplePostToolTest, TestCoreDiscovery,
SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, CoreAdminHandlerTest,
TestFoldingMultitermQuery, DocValuesTest, SuggesterTest, TestCSVLoader,
NoCacheHeaderTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest,
TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory,
DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest,
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest,
XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest,
TestSurroundQueryParser, TestQueryUtils, TestWriterPerf,
DirectSolrSpellCheckerTest, TestQueryTypes, FileBasedSpellCheckerTest,
TermsComponentTest, XmlUpdateRequestHandlerTest, RequestHandlersTest,
DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest,
MoreLikeThisHandlerTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest,
TestSolrQueryParser, FastVectorHighlighterTest, LoggingHandlerTest,
SolrPluginUtilsTest, TestJmxIntegration, ReturnFieldsTest,
TestCSVResponseWriter, QueryParsingTest, TestAnalyzedSuggestions,
UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, TestLFUCache, HighlighterConfigTest,
UpdateParamsTest, TestSolrIndexConfig, TestMergePolicyConfig,
TestSolrDeletionPolicy2, MultiTermTest, SampleTest, NumericFieldsTest,
MinimalSchemaTest, OutputWriterTest, TestFuzzyAnalyzedSuggestions,
ExternalFileFieldSortTest, TestPostingsSolrHighlighter,
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions,
SpellPossibilityIteratorTest, TestCharFilters, TestXIncludeConfig,
TestDFRSimilarityFactory, TestPerFieldSimilarity,
TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory,
TestBM25SimilarityFactory, ResourceLoaderTest, ScriptEngineTest,
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, TestFastLRUCache,
DateMathParserTest, PreAnalyzedFieldTest, TestSystemIdResolver, DateFieldTest,
RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils,
ZkNodePropsTest, SliceStateTest, UUIDFieldTest, TestRTGBase, CursorPagingTest,
SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping,
TestTolerantSearch, TestLuceneIndexBackCompat, TestEmbeddedSolrServerSchemaAPI,
AssignTest, CleanupOldIndexTest, CollectionReloadTest,
CollectionStateFormat2Test, CreateCollectionCleanupTest, CustomCollectionTest,
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest,
DistribJoinFromCollectionTest, DistributedQueueTest, ForceLeaderTest,
LeaderFailureAfterFreshStartTest, LegacyCloudClusterPropTest,
MigrateRouteKeyTest]
[junit4] Completed [749/749 (3!)] on J2 in 1354.02s, 1 test, 1 failure <<<
FAILURES!
[...truncated 47304 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
