Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.2/25/
3 tests failed.
FAILED: org.apache.solr.cloud.ShardSplitTest.testSplitAfterFailedSplit
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([85BA77DDAF84367A:7CF7E47293F17BF0]: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.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.ShardSplitTest.testSplitAfterFailedSplit(ShardSplitTest.java:279)
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.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
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.ShardSplitTest.testSplitWithChaosMonkey
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([85BA77DDAF84367A:E9DA40CEE829DFE]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:185)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:140)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:907)
at
org.apache.solr.cloud.ShardSplitTest.testSplitWithChaosMonkey(ShardSplitTest.java:428)
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.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
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.AutoScalingHandlerTest.testReadApi
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([85BA77DDAF84367A:D2938C687476D461]: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.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:724)
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 11634 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.2/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_85BA77DDAF84367A-001/init-core-data-001
[junit4] 2> 105851 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 105852 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 105852 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 105854 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.2/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_85BA77DDAF84367A-001/tempDir-001
[junit4] 2> 105948 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 105967 INFO (Thread-30) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 105980 INFO (Thread-30) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 106587 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:45939
[junit4] 2> 107186 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Exception causing close of session 0x0 due to
java.io.IOException: ZooKeeperServer not running
[junit4] 2> 107273 ERROR (Thread-30) [ ] 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> 109227 INFO (zkConnectionManagerCallback-20-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 109453 INFO (jetty-launcher-17-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 109455 INFO (jetty-launcher-17-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@47471525{/solr,null,AVAILABLE}
[junit4] 2> 109469 INFO (jetty-launcher-17-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 109470 INFO (jetty-launcher-17-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ffc1990{/solr,null,AVAILABLE}
[junit4] 2> 109469 INFO (jetty-launcher-17-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@60b5d982{HTTP/1.1,[http/1.1]}{127.0.0.1:45236}
[junit4] 2> 109471 INFO (jetty-launcher-17-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@23581f67{HTTP/1.1,[http/1.1]}{127.0.0.1:34624}
[junit4] 2> 109471 INFO (jetty-launcher-17-thread-2) [ ]
o.e.j.s.Server Started @119060ms
[junit4] 2> 109471 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34624}
[junit4] 2> 109471 ERROR (jetty-launcher-17-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 109472 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.2.2
[junit4] 2> 109481 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 109481 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 109481 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-15T15:16:57.657Z
[junit4] 2> 109480 INFO (jetty-launcher-17-thread-1) [ ]
o.e.j.s.Server Started @119059ms
[junit4] 2> 109481 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45236}
[junit4] 2> 109482 ERROR (jetty-launcher-17-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 109482 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.2.2
[junit4] 2> 109482 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 109482 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 109482 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-15T15:16:57.658Z
[junit4] 2> 109496 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 109515 INFO (zkConnectionManagerCallback-22-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 109516 INFO (zkConnectionManagerCallback-24-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 109533 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 109533 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 109671 INFO (jetty-launcher-17-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45939/solr
[junit4] 2> 109744 INFO (jetty-launcher-17-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45939/solr
[junit4] 2> 109746 INFO (zkConnectionManagerCallback-28-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 109818 INFO (zkConnectionManagerCallback-32-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 109988 INFO
(zkConnectionManagerCallback-34-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 110051 INFO
(zkConnectionManagerCallback-36-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 113207 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 113208 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 113224 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45236_solr
[junit4] 2> 113225 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.c.Overseer Overseer
(id=99354503722762246-127.0.0.1:45236_solr-n_0000000000) starting
[junit4] 2> 113240 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34624_solr
[junit4] 2> 113407 INFO
(zkCallback-33-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 113608 INFO
(zkCallback-35-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 114475 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45236_solr
[junit4] 2> 114649 INFO
(zkCallback-33-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 114685 INFO
(zkCallback-35-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 115947 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45236.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 115965 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34624.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 116188 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45236.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 116237 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45236.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 116197 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34624.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 116253 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34624.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@59fba84
[junit4] 2> 116255 INFO (jetty-launcher-17-thread-1)
[n:127.0.0.1:45236_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.2/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_85BA77DDAF84367A-001/tempDir-001/node1/.
[junit4] 2> 116255 INFO (jetty-launcher-17-thread-2)
[n:127.0.0.1:34624_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.2/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_85BA77DDAF84367A-001/tempDir-001/node2/.
[junit4] 2> 117990 INFO (zkConnectionManagerCallback-41-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 118101 INFO (zkConnectionManagerCallback-45-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 118103 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 118133 INFO
(SUITE-AutoScalingHandlerTest-seed#[85BA77DDAF84367A]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 118226 INFO
(TEST-AutoScalingHandlerTest.test-seed#[85BA77DDAF84367A]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 118582 INFO
(zkConnectionManagerCallback-49-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 118599 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 118600 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 118904 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=178
[junit4] 2> 119106 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 119143 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=814
[junit4] 2> 119267 INFO
(zkConnectionManagerCallback-53-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 119285 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 119286 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 119320 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 119322 INFO (qtp1896149770-159) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 119357 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=178
[junit4] 2> 119615 INFO
(zkConnectionManagerCallback-57-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 119685 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 119686 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 119688 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 119705 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 119729 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=278
[junit4] 2> 119732 ERROR (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.h.RequestHandlerBase org.apache.solr.api.ApiBag$ExceptionWithErrObject:
Error in command payload, errors: [{remove-trigger={name=node_lost_trigger},
errorMessages=[Cannot remove trigger: node_lost_trigger because it has active
listeners: [xyz, node_lost_trigger.system]]}],
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:214)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:145)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
[junit4] 2> at
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
[junit4] 2> at
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:311)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 119732 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=400 QTime=1
[junit4] 2> 119935 INFO
(zkConnectionManagerCallback-61-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 120012 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 120065 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 120086 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 120088 INFO (qtp1896149770-159) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 120122 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=344
[junit4] 2> 120373 INFO
(zkConnectionManagerCallback-65-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 120462 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 120483 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 120484 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 120486 INFO (qtp1896149770-159) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 120665 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=540
[junit4] 2> 120713 ERROR (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.h.RequestHandlerBase org.apache.solr.api.ApiBag$ExceptionWithErrObject:
Error in command payload, errors: [{set-listener={name=xyz,
trigger=node_lost_trigger, stage=[STARTED, ABORTED, SUCCEEDED],
beforeAction=execute_plan,
class=org.apache.solr.cloud.autoscaling.AutoScaling$HttpTriggerListener,
url=http://xyz.com/on_node_lost?node={$LOST_NODE_NAME}}, errorMessages=[A
trigger with the name node_lost_trigger does not exist]}],
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:214)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:145)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
[junit4] 2> at
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
[junit4] 2> at
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:311)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 120765 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=400 QTime=72
[junit4] 2> 120767 INFO
(TEST-AutoScalingHandlerTest.test-seed#[85BA77DDAF84367A]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 120986 INFO
(TEST-AutoScalingHandlerTest.testSetProperties-seed#[85BA77DDAF84367A]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSetProperties
[junit4] 2> 121171 INFO
(zkConnectionManagerCallback-69-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 121237 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 121238 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 121239 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 121260 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 121346 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=323
[junit4] 2> 121356 INFO (qtp309575990-165) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 121438 INFO
(zkConnectionManagerCallback-73-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 121479 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 121480 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 121557 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 121559 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 121629 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=259
[junit4] 2> 121632 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 121847 INFO
(zkConnectionManagerCallback-77-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 121951 INFO (qtp309575990-165) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 121970 INFO (qtp309575990-165) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 121972 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 121988 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122046 INFO (qtp309575990-165) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=377
[junit4] 2> 122066 INFO (qtp1896149770-159) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=18
[junit4] 2> 122134 INFO
(zkConnectionManagerCallback-81-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122148 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122148 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122149 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122151 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122189 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 0x160fa650d3b0011, 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> 122277 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=209
[junit4] 2> 122297 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=16
[junit4] 2> 122334 INFO
(zkConnectionManagerCallback-85-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122335 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122354 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122356 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122370 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122393 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=94
[junit4] 2> 122427 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=32
[junit4] 2> 122427 INFO
(TEST-AutoScalingHandlerTest.testSetProperties-seed#[85BA77DDAF84367A]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testSetProperties
[junit4] 2> 122515 INFO
(TEST-AutoScalingHandlerTest.testConcurrentUpdates-seed#[85BA77DDAF84367A]) [
] o.a.s.SolrTestCaseJ4 ###Starting testConcurrentUpdates
[junit4] 2> 122654 INFO
(zkConnectionManagerCallback-89-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122670 INFO
(zkConnectionManagerCallback-93-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122671 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122671 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122672 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122673 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122674 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122675 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122676 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122677 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122727 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=109
[junit4] 2> 122812 INFO
(zkConnectionManagerCallback-101-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122813 INFO
(zkConnectionManagerCallback-97-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 122851 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122852 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 122886 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122887 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122893 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122921 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 122923 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122924 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 122961 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 0x160fa650d3b0015, 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> 122977 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=213
[junit4] 2> 123022 INFO
(zkConnectionManagerCallback-105-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123084 INFO
(zkConnectionManagerCallback-109-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123085 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123086 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123099 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123100 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123102 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123103 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123148 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123149 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123180 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=598
[junit4] 2> 123228 INFO
(zkConnectionManagerCallback-117-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123257 INFO
(zkConnectionManagerCallback-113-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123291 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123292 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123312 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123326 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123343 INFO (qtp309575990-165) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123344 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123347 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123348 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123349 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 0x160fa650d3b001a, 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> 123359 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=350
[junit4] 2> 123444 INFO
(zkConnectionManagerCallback-121-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123504 INFO
(zkConnectionManagerCallback-125-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123509 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123510 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123511 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123559 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123598 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=233
[junit4] 2> 123602 INFO
(zkConnectionManagerCallback-129-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123621 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123622 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123622 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123622 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123623 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123624 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123639 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123639 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123641 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=41
[junit4] 2> 123784 INFO
(zkConnectionManagerCallback-137-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123798 INFO
(zkConnectionManagerCallback-133-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123817 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123817 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123818 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123819 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123832 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 123833 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123836 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123837 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 123932 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=267
[junit4] 2> 123987 INFO
(zkConnectionManagerCallback-143-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123994 INFO
(zkConnectionManagerCallback-145-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 123999 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 123999 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124000 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124000 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124001 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124002 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124011 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124012 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124036 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=103
[junit4] 2> 124108 INFO
(zkConnectionManagerCallback-149-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 124113 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124113 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124114 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124128 INFO
(zkConnectionManagerCallback-153-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 124141 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124157 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124158 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124169 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124177 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124229 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 0x160fa650d3b0022, 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> 124270 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=1088
[junit4] 2> 124428 INFO
(zkConnectionManagerCallback-157-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 124615 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124616 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124639 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124640 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124707 INFO
(zkConnectionManagerCallback-161-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 124720 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=682
[junit4] 2> 124815 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124816 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124833 INFO
(zkConnectionManagerCallback-165-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 124873 INFO (qtp309575990-171) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=23
[junit4] 2> 124886 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 124887 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 124888 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124889 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 124895 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125121 INFO
(zkConnectionManagerCallback-169-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125122 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125123 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125124 INFO (qtp309575990-166) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125158 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125226 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=505
[junit4] 2> 125246 INFO
(zkConnectionManagerCallback-173-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125247 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125248 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125249 INFO
(zkConnectionManagerCallback-177-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125258 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125259 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125283 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125284 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125285 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125286 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125426 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=194
[junit4] 2> 125582 INFO
(zkConnectionManagerCallback-181-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125606 INFO
(zkConnectionManagerCallback-185-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125647 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125667 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125668 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125669 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125670 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125683 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125685 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125736 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125772 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=331
[junit4] 2> 125829 INFO
(zkConnectionManagerCallback-189-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 125872 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 125872 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 125882 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125883 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 125885 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=111
[junit4] 2> 126023 INFO
(zkConnectionManagerCallback-193-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126026 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126027 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126043 INFO
(zkConnectionManagerCallback-197-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126045 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126046 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126134 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126135 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126136 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126161 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126169 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=234
[junit4] 2> 126206 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 0x160fa650d3b002d, 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> 126315 INFO
(zkConnectionManagerCallback-201-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126320 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126320 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126321 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126342 INFO
(zkConnectionManagerCallback-205-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126351 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126368 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=198
[junit4] 2> 126371 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126391 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126404 INFO
(zkConnectionManagerCallback-209-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126404 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126406 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126407 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126407 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126412 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126444 INFO (qtp1896149770-155) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126479 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=109
[junit4] 2> 126586 INFO
(zkConnectionManagerCallback-213-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126607 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126608 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126609 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126737 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126769 INFO (qtp1896149770-160) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=235
[junit4] 2> 126794 INFO
(zkConnectionManagerCallback-217-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126798 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126798 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126800 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126809 INFO
(zkConnectionManagerCallback-221-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 126822 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 126824 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 126824 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126842 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 126846 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 128793 INFO (qtp309575990-172) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=2022
[junit4] 2> 128883 INFO
(zkConnectionManagerCallback-225-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 128900 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 128901 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 128902 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 128916 INFO (qtp1896149770-156) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129009 INFO (qtp309575990-168) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling
params={wt=javabin&version=2} status=0 QTime=180
[junit4] 2> 129011 INFO
(zkConnectionManagerCallback-229-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 129045 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 129077 INFO
(zkConnectionManagerCallback-233-thread-1-processing-n:127.0.0.1:34624_solr)
[n:127.0.0.1:34624_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 129114 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 129115 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129131 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129166 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 129171 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 129172 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129173 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129191 INFO
(zkConnectionManagerCallback-237-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 129191 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 0x160fa650d3b0037, 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> 129192 INFO (qtp309575990-169) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling
params={wt=javabin&version=2} status=0 QTime=181
[junit4] 2> 129194 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 129238 INFO
(zkConnectionManagerCallback-241-thread-1-processing-n:127.0.0.1:45236_solr)
[n:127.0.0.1:45236_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 129239 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 129244 INFO (qtp1896149770-162) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 129244 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129252 INFO (qtp1896149770-161) [n:127.0.0.1:45236_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CORE.coreName&wt=javabin&version=2&group=solr.core} status=0
QTime=0
[junit4] 2> 129272 INFO (qtp1896149770-158) [n:127.0.0.1:45236_solr ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45939/solr ready
[junit4] 2> 129273 INFO (qtp309575990-170) [n:127.0.0.1:34624_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={pr
[...truncated too long message...]
collection.collection1.shard1.leader, tag=1756962566
[junit4] 2> 1934654 INFO (coreCloseExecutor-1915-thread-2)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1 r:core_node3
x:routeFieldColl_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.routeFieldColl.shard1.replica_n1,
tag=1453833207
[junit4] 2> 1934654 INFO (coreCloseExecutor-1915-thread-2)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1 r:core_node3
x:routeFieldColl_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3157a5d4: rootName = null,
domain = solr.core.routeFieldColl.shard1.replica_n1, service url = null, agent
id = null] for registry solr.core.routeFieldColl.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@6731ee9a
[junit4] 2> 1934660 INFO (coreCloseExecutor-1915-thread-2)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1 r:core_node3
x:routeFieldColl_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.routeFieldColl.shard1.leader,
tag=1453833207
[junit4] 2> 1934660 INFO (coreCloseExecutor-1915-thread-3)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard3 r:core_node13
x:routeFieldColl_shard3_replica_n10] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.routeFieldColl.shard3.replica_n10,
tag=104791187
[junit4] 2> 1934660 INFO (coreCloseExecutor-1915-thread-3)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard3 r:core_node13
x:routeFieldColl_shard3_replica_n10] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@19d93140: rootName = null,
domain = solr.core.routeFieldColl.shard3.replica_n10, service url = null, agent
id = null] for registry solr.core.routeFieldColl.shard3.replica_n10 /
com.codahale.metrics.MetricRegistry@75750668
[junit4] 2> 1934668 INFO (coreCloseExecutor-1915-thread-3)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard3 r:core_node13
x:routeFieldColl_shard3_replica_n10] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.routeFieldColl.shard3.leader,
tag=104791187
[junit4] 2> 1934668 INFO (coreCloseExecutor-1915-thread-4)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_0 r:core_node19
x:routeFieldColl_shard1_0_replica_n17] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.routeFieldColl.shard1_0.replica_n17,
tag=550985250
[junit4] 2> 1934669 INFO (coreCloseExecutor-1915-thread-4)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_0 r:core_node19
x:routeFieldColl_shard1_0_replica_n17] o.a.s.m.r.SolrJmxReporter Closing
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@167ad57: rootName =
null, domain = solr.core.routeFieldColl.shard1_0.replica_n17, service url =
null, agent id = null] for registry
solr.core.routeFieldColl.shard1_0.replica_n17 /
com.codahale.metrics.MetricRegistry@4422d9fa
[junit4] 2> 1934739 INFO (coreCloseExecutor-1915-thread-5)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_1 r:core_node20
x:routeFieldColl_shard1_1_replica_n18] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.routeFieldColl.shard1_1.replica_n18,
tag=2112650592
[junit4] 2> 1934739 INFO (coreCloseExecutor-1915-thread-5)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_1 r:core_node20
x:routeFieldColl_shard1_1_replica_n18] o.a.s.m.r.SolrJmxReporter Closing
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@71604a06: rootName
= null, domain = solr.core.routeFieldColl.shard1_1.replica_n18, service url =
null, agent id = null] for registry
solr.core.routeFieldColl.shard1_1.replica_n18 /
com.codahale.metrics.MetricRegistry@2b94042b
[junit4] 2> 1934753 INFO (coreCloseExecutor-1915-thread-5)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_1 r:core_node20
x:routeFieldColl_shard1_1_replica_n18] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.routeFieldColl.shard1_1.leader,
tag=2112650592
[junit4] 2> 1934753 INFO (coreCloseExecutor-1915-thread-6)
[n:127.0.0.1:36448_ c:splitByRouteKeyTest s:shard2 r:core_node8
x:splitByRouteKeyTest_shard2_replica_n7] o.a.s.m.SolrMetricManager Closing
metric reporters for registry=solr.core.splitByRouteKeyTest.shard2.replica_n7,
tag=978031684
[junit4] 2> 1934753 INFO (coreCloseExecutor-1915-thread-6)
[n:127.0.0.1:36448_ c:splitByRouteKeyTest s:shard2 r:core_node8
x:splitByRouteKeyTest_shard2_replica_n7] o.a.s.m.r.SolrJmxReporter Closing
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@39cb9649: rootName
= null, domain = solr.core.splitByRouteKeyTest.shard2.replica_n7, service url =
null, agent id = null] for registry
solr.core.splitByRouteKeyTest.shard2.replica_n7 /
com.codahale.metrics.MetricRegistry@4dd99d3f
[junit4] 2> 1934759 INFO (coreCloseExecutor-1915-thread-6)
[n:127.0.0.1:36448_ c:splitByRouteKeyTest s:shard2 r:core_node8
x:splitByRouteKeyTest_shard2_replica_n7] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.splitByRouteKeyTest.shard2.leader, tag=978031684
[junit4] 2> 1934759 INFO (coreCloseExecutor-1915-thread-4)
[n:127.0.0.1:36448_ c:routeFieldColl s:shard1_0 r:core_node19
x:routeFieldColl_shard1_0_replica_n17] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.routeFieldColl.shard1_0.leader,
tag=550985250
[junit4] 2> 1934765 INFO
(TEST-ShardSplitTest.test-seed#[85BA77DDAF84367A]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@5ed137d1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1934765 INFO
(TEST-ShardSplitTest.test-seed#[85BA77DDAF84367A]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7252cee1{/,null,UNAVAILABLE}
[junit4] 2> 1934767 INFO
(TEST-ShardSplitTest.test-seed#[85BA77DDAF84367A]) [ ] o.a.s.c.ChaosMonkey
monkey: stop jetty! 33956
[junit4] 2> 1934767 ERROR
(TEST-ShardSplitTest.test-seed#[85BA77DDAF84367A]) [ ]
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> 1934781 INFO
(TEST-ShardSplitTest.test-seed#[85BA77DDAF84367A]) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:33697 33697
[junit4] 2> 1934965 INFO (Thread-894) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:33697 33697
[junit4] 2> 1934970 WARN (Thread-894) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/aliases.json
[junit4] 2> 10 /solr/collections/splitByRouteKeyTest/state.json
[junit4] 2> 9 /solr/collections/routeFieldColl/state.json
[junit4] 2> 6 /solr/collections/collection1/state.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/clusterprops.json
[junit4] 2> 10 /solr/clusterstate.json
[junit4] 2> 4 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/live_nodes
[junit4] 2> 10 /solr/collections
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2> 4 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 4 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.2/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_85BA77DDAF84367A-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{rnd_b=PostingsFormat(name=MockRandom), shard_s=PostingsFormat(name=Direct),
a_t=PostingsFormat(name=Direct), id=PostingsFormat(name=MockRandom)},
docValues:{rnd_b=DocValuesFormat(name=Asserting),
shard_s=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Lucene70), n_ti=DocValuesFormat(name=Lucene70),
a_t=DocValuesFormat(name=Lucene70), a_i=DocValuesFormat(name=Asserting),
id=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=971,
maxMBSortInHeap=5.004776660429856, sim=RandomSimilarity(queryNorm=false): {},
locale=es-DO, timezone=America/Kentucky/Louisville
[junit4] 2> NOTE: Linux 4.4.0-104-generic amd64/Oracle Corporation
1.8.0_152 (64-bit)/cpus=4,threads=1,free=209088192,total=523763712
[junit4] 2> NOTE: All tests run in this JVM: [TestWriterPerf,
TestCoreAdminApis, TestFaceting, RequestHandlersTest,
TestCollationFieldDocValues, SolrIndexMetricsTest, TestFieldTypeResource,
SubstringBytesRefFilterTest, TestRuleBasedAuthorizationPlugin,
AutoScalingHandlerTest, AssignTest, DeleteLastCustomShardedReplicaTest,
HdfsRecoverLeaseTest, CoreAdminCreateDiscoverTest,
ShufflingReplicaListTransformerTest, TestSolr4Spatial, ZkCLITest,
QueryEqualityTest, TestBulkSchemaConcurrent, TestPseudoReturnFields,
ShowFileRequestHandlerTest, TestSolrQueryParser, TestSolrQueryResponse,
TestLeaderElectionZkExpiry, TestFileDictionaryLookup, ZkSolrClientTest,
TestLegacyNumericUtils, CdcrReplicationHandlerTest,
ExitableDirectoryReaderTest, TestJmxIntegration, TestRemoteStreaming,
ConfigureRecoveryStrategyTest, CircularListTest,
DistributedQueryComponentCustomSortTest, TestPerFieldSimilarity,
TestExclusionRuleCollectionAccess, CloudExitableDirectoryReaderTest,
LukeRequestHandlerTest, MoreLikeThisHandlerTest, TestClusterStateMutator,
PolyFieldTest, TestGraphTermsQParserPlugin, TestSizeLimitedDistributedMap,
TestRangeQuery, TestDocumentBuilder, TestRandomFlRTGCloud,
SuggestComponentTest, TestCollationField, TestStressReorder,
HttpSolrCallGetCoreTest, CdcrUpdateLogTest, OverseerRolesTest,
SynonymTokenizerTest, RegexBoostProcessorTest, NodeLostTriggerTest,
SuggesterTSTTest, ShardSplitTest]
[junit4] Completed [282/751 (2!)] on J1 in 812.15s, 5 tests, 2 failures <<<
FAILURES!
[...truncated 48823 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
