Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2181/
2 tests failed.
FAILED:
org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest.test
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([76B46F21D3099A38:FEE050FB7DF5F7C0]: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.update.processor.TimePartitionedUpdateProcessorTest.assertInvariants(TimePartitionedUpdateProcessorTest.java:245)
at
org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest.test(TimePartitionedUpdateProcessorTest.java:123)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([76B46F21D3099A38:219D949408FB7823]: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:709)
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 11940 lines...]
[junit4] Suite:
org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/init-core-data-001
[junit4] 2> 1070105 WARN
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 1070105 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1070176 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1070177 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1070177 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001
[junit4] 2> 1070177 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1070187 INFO (Thread-778) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1070187 INFO (Thread-778) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1070207 ERROR (Thread-778) [ ] 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> 1070287 INFO
(SUITE-TimePartitionedUpdateProcessorTest-seed#[76B46F21D3099A38]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:42146
[junit4] 2> 1070350 INFO (jetty-launcher-785-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1070367 INFO (jetty-launcher-785-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1070427 INFO (jetty-launcher-785-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@39fdc80c{/solr,null,AVAILABLE}
[junit4] 2> 1070428 INFO (jetty-launcher-785-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3962c0e8{SSL,[ssl,
http/1.1]}{127.0.0.1:42358}
[junit4] 2> 1070428 INFO (jetty-launcher-785-thread-2) [ ]
o.e.j.s.Server Started @1089563ms
[junit4] 2> 1070429 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42358}
[junit4] 2> 1070429 ERROR (jetty-launcher-785-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1070429 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1070429 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1070429 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1070429 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-18T16:36:12.893Z
[junit4] 2> 1070537 INFO (jetty-launcher-785-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7045d104{/solr,null,AVAILABLE}
[junit4] 2> 1070537 INFO (jetty-launcher-785-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@cb483bd{SSL,[ssl,
http/1.1]}{127.0.0.1:34123}
[junit4] 2> 1070537 INFO (jetty-launcher-785-thread-1) [ ]
o.e.j.s.Server Started @1089671ms
[junit4] 2> 1070537 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34123}
[junit4] 2> 1070538 ERROR (jetty-launcher-785-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1070538 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1070538 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1070538 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1070538 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-18T16:36:13.002Z
[junit4] 2> 1070728 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1070754 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1070793 INFO (jetty-launcher-785-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42146/solr
[junit4] 2> 1070860 INFO (jetty-launcher-785-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42146/solr
[junit4] 2> 1071223 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1071389 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:42358_solr
[junit4] 2> 1071390 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.c.Overseer Overseer
(id=99026401535721477-127.0.0.1:42358_solr-n_0000000000) starting
[junit4] 2> 1071534 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42358_solr
[junit4] 2> 1071591 INFO
(OverseerStateUpdate-99026401535721477-127.0.0.1:42358_solr-n_0000000000)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1071755 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42358.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1071806 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42358.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1071806 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42358.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1071807 INFO (jetty-launcher-785-thread-2)
[n:127.0.0.1:42358_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/.
[junit4] 2> 1072451 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1072453 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1072471 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34123_solr
[junit4] 2> 1072486 INFO
(zkCallback-796-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1072531 INFO
(zkCallback-797-thread-1-processing-n:127.0.0.1:34123_solr)
[n:127.0.0.1:34123_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1072641 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34123.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1072753 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34123.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1072753 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34123.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1072754 INFO (jetty-launcher-785-thread-1)
[n:127.0.0.1:34123_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node1/.
[junit4] 2> 1072903 INFO
(TEST-TimePartitionedUpdateProcessorTest.test-seed#[76B46F21D3099A38]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1072934 INFO
(TEST-TimePartitionedUpdateProcessorTest.test-seed#[76B46F21D3099A38]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1072934 INFO
(TEST-TimePartitionedUpdateProcessorTest.test-seed#[76B46F21D3099A38]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42146/solr ready
[junit4] 2> 1073357 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&replicationFactor=1&name=timeConfig&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1073456 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.CreateCollectionCmd Create collection
timeConfig
[junit4] 2> 1073464 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.CreateCollectionCmd Only _default config
set found, using it.
[junit4] 2> 1073477 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/protwords.txt to /configs/timeConfig/protwords.txt
[junit4] 2> 1073478 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/managed-schema to /configs/timeConfig/managed-schema
[junit4] 2> 1073479 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/solrconfig.xml to /configs/timeConfig/solrconfig.xml
[junit4] 2> 1073513 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/synonyms.txt to /configs/timeConfig/synonyms.txt
[junit4] 2> 1073514 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/stopwords.txt to /configs/timeConfig/stopwords.txt
[junit4] 2> 1073515 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/params.json to /configs/timeConfig/params.json
[junit4] 2> 1073516 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_it.txt to
/configs/timeConfig/lang/contractions_it.txt
[junit4] 2> 1073553 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_no.txt to
/configs/timeConfig/lang/stopwords_no.txt
[junit4] 2> 1073555 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hy.txt to
/configs/timeConfig/lang/stopwords_hy.txt
[junit4] 2> 1073555 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stemdict_nl.txt to
/configs/timeConfig/lang/stemdict_nl.txt
[junit4] 2> 1073556 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ca.txt to
/configs/timeConfig/lang/contractions_ca.txt
[junit4] 2> 1073569 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_id.txt to
/configs/timeConfig/lang/stopwords_id.txt
[junit4] 2> 1073571 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ga.txt to
/configs/timeConfig/lang/stopwords_ga.txt
[junit4] 2> 1073572 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_da.txt to
/configs/timeConfig/lang/stopwords_da.txt
[junit4] 2> 1073573 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hi.txt to
/configs/timeConfig/lang/stopwords_hi.txt
[junit4] 2> 1073574 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ja.txt to
/configs/timeConfig/lang/stopwords_ja.txt
[junit4] 2> 1073575 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_pt.txt to
/configs/timeConfig/lang/stopwords_pt.txt
[junit4] 2> 1073576 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_hu.txt to
/configs/timeConfig/lang/stopwords_hu.txt
[junit4] 2> 1073577 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_el.txt to
/configs/timeConfig/lang/stopwords_el.txt
[junit4] 2> 1073598 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ru.txt to
/configs/timeConfig/lang/stopwords_ru.txt
[junit4] 2> 1073599 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_tr.txt to
/configs/timeConfig/lang/stopwords_tr.txt
[junit4] 2> 1073619 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ar.txt to
/configs/timeConfig/lang/stopwords_ar.txt
[junit4] 2> 1073620 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/userdict_ja.txt to
/configs/timeConfig/lang/userdict_ja.txt
[junit4] 2> 1073621 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_it.txt to
/configs/timeConfig/lang/stopwords_it.txt
[junit4] 2> 1073635 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_eu.txt to
/configs/timeConfig/lang/stopwords_eu.txt
[junit4] 2> 1073636 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_cz.txt to
/configs/timeConfig/lang/stopwords_cz.txt
[junit4] 2> 1073637 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stoptags_ja.txt to
/configs/timeConfig/lang/stoptags_ja.txt
[junit4] 2> 1073638 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_fr.txt to
/configs/timeConfig/lang/contractions_fr.txt
[junit4] 2> 1073639 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fa.txt to
/configs/timeConfig/lang/stopwords_fa.txt
[junit4] 2> 1073640 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_de.txt to
/configs/timeConfig/lang/stopwords_de.txt
[junit4] 2> 1073641 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/contractions_ga.txt to
/configs/timeConfig/lang/contractions_ga.txt
[junit4] 2> 1073655 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ca.txt to
/configs/timeConfig/lang/stopwords_ca.txt
[junit4] 2> 1073656 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_nl.txt to
/configs/timeConfig/lang/stopwords_nl.txt
[junit4] 2> 1073658 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_bg.txt to
/configs/timeConfig/lang/stopwords_bg.txt
[junit4] 2> 1073667 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_es.txt to
/configs/timeConfig/lang/stopwords_es.txt
[junit4] 2> 1073668 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_en.txt to
/configs/timeConfig/lang/stopwords_en.txt
[junit4] 2> 1073669 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_lv.txt to
/configs/timeConfig/lang/stopwords_lv.txt
[junit4] 2> 1073669 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_th.txt to
/configs/timeConfig/lang/stopwords_th.txt
[junit4] 2> 1073689 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_ro.txt to
/configs/timeConfig/lang/stopwords_ro.txt
[junit4] 2> 1073690 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fr.txt to
/configs/timeConfig/lang/stopwords_fr.txt
[junit4] 2> 1073704 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_sv.txt to
/configs/timeConfig/lang/stopwords_sv.txt
[junit4] 2> 1073705 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_fi.txt to
/configs/timeConfig/lang/stopwords_fi.txt
[junit4] 2> 1073706 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/hyphenations_ga.txt to
/configs/timeConfig/lang/hyphenations_ga.txt
[junit4] 2> 1073707 INFO
(OverseerThreadFactory-1339-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkConfigManager Copying zk node
/configs/_default/lang/stopwords_gl.txt to
/configs/timeConfig/lang/stopwords_gl.txt
[junit4] 2> 1073847 INFO
(OverseerStateUpdate-99026401535721477-127.0.0.1:42358_solr-n_0000000000)
[n:127.0.0.1:42358_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"timeConfig",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"timeConfig_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:42358/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1074151 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=timeConfig&newCollection=true&name=timeConfig_shard1_replica_n1&action=CREATE&numShards=1&collection=timeConfig&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1074151 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1074520 INFO
(zkCallback-796-thread-2-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1074556 INFO
(zkCallback-796-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1075394 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1075394 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/extraction/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-cell-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/clustering/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-clustering-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/langid/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 1075395 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-langid-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1075396 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/velocity/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 1075396 WARN (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-velocity-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1075467 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1075651 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.IndexSchema [timeConfig_shard1_replica_n1] Schema name=default-config
[junit4] 2> 1076498 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 1076591 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'timeConfig_shard1_replica_n1' using
configuration from collection timeConfig, trusted=true
[junit4] 2> 1076591 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42358.solr.core.timeConfig.shard1.replica_n1' (registry
'solr.core.timeConfig.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1076591 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1076591 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrCore [[timeConfig_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/./timeConfig_shard1_replica_n1/data/]
[junit4] 2> 1076622 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1076968 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1076968 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1076969 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1076969 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1076970 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@52b0a019[timeConfig_shard1_replica_n1] main]
[junit4] 2> 1076971 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/timeConfig
[junit4] 2> 1076971 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/timeConfig
[junit4] 2> 1076971 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/timeConfig/managed-schema
[junit4] 2> 1076972 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1076973 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1076973 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.DirectSolrSpellChecker init:
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 1076974 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1076975 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1584422431688228864
[junit4] 2> 1076983 INFO
(searcherExecutor-1344-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
sending requests to Searcher@52b0a019[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1076983 INFO
(searcherExecutor-1344-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
done.
[junit4] 2> 1076983 INFO
(searcherExecutor-1344-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 1077021 INFO
(searcherExecutor-1344-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.SolrCore [timeConfig_shard1_replica_n1]
Registered new searcher Searcher@52b0a019[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1077034 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1077034 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1077035 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/
[junit4] 2> 1077035 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1077035 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SyncStrategy https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/
has no replicas
[junit4] 2> 1077035 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1077049 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ shard1
[junit4] 2> 1077074 INFO
(zkCallback-796-thread-2-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1077074 INFO
(zkCallback-796-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1077100 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1077114 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=timeConfig&newCollection=true&name=timeConfig_shard1_replica_n1&action=CREATE&numShards=1&collection=timeConfig&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2963
[junit4] 2> 1077175 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1077220 INFO
(zkCallback-796-thread-2-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1077220 INFO
(zkCallback-796-thread-1-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/timeConfig/state.json] for collection [timeConfig] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1077548 INFO
(OverseerCollectionConfigSetProcessor-99026401535721477-127.0.0.1:42358_solr-n_0000000000)
[n:127.0.0.1:42358_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1078177 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&replicationFactor=1&name=timeConfig&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
status=0 QTime=4820
[junit4] 2> 1078454 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler Executed config commands successfully and persisted
to ZK [{"set-user-property":{"timePartitionAliasName":"myalias"}},
{"set-user-property":{"update.autoCreateFields":false}},
{"add-updateprocessor":{
[junit4] 2> "name":"tolerant",
[junit4] 2> "class":"solr.TolerantUpdateProcessorFactory"}},
{"add-updateprocessor":{
[junit4] 2> "name":"inc",
[junit4] 2>
"class":"org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest$IncrementURPFactory",
[junit4] 2> "fieldName":"integer_i"}}]
[junit4] 2> 1078454 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the
property overlay to be of version 0 for collection timeConfig
[junit4] 2> 1078458 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrCore config update listener called for core
timeConfig_shard1_replica_n1
[junit4] 2> 1078495 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrCore core reload timeConfig_shard1_replica_n1
[junit4] 2> 1078507 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1078600 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 1078600 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 1078600 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/extraction/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 1078635 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-cell-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1078635 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/clustering/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 1078635 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-clustering-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1078635 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/langid/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 1078635 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-langid-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1078636 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/velocity/lib
filtered by .*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 1078636 WARN (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
filtered by solr-velocity-\d.*\.jar to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1/../../../../dist
[junit4] 2> 1078686 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1078694 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=8
[junit4] 2> 1078706 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 1 attempts
[junit4] 2> 1078706 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1078715 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1078722 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1078823 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.s.IndexSchema [timeConfig_shard1_replica_n1] Schema name=default-config
[junit4] 2> 1078930 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1078931 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1078931 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1078979 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 2 attempts
[junit4] 2> 1078979 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1079166 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1079178 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=11
[junit4] 2> 1079178 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1079190 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 3 attempts
[junit4] 2> 1079190 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1079333 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1079349 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=15
[junit4] 2> 1079349 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1079361 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 4 attempts
[junit4] 2> 1079361 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1079495 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1079496 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1079496 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1079523 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 5 attempts
[junit4] 2> 1079523 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1079658 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1079678 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=19
[junit4] 2> 1079678 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1079678 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 6 attempts
[junit4] 2> 1079678 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1079825 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1079826 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=1
[junit4] 2> 1079827 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1079827 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 7 attempts
[junit4] 2> 1079827 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1079912 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 1080003 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1080023 INFO (Thread-797) [n:127.0.0.1:42358_solr ]
o.a.s.c.CoreContainer Reloading SolrCore 'timeConfig_shard1_replica_n1' using
configuration from collection timeConfig
[junit4] 2> 1080072 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=68
[junit4] 2> 1080129 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1080149 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 8 attempts
[junit4] 2> 1080149 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1080219 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_42358.solr.core.timeConfig.shard1.replica_n1' (registry
'solr.core.timeConfig.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6070537e
[junit4] 2> 1080219 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrCore [[timeConfig_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/timeConfig_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_76B46F21D3099A38-001/tempDir-001/node2/./timeConfig_shard1_replica_n1/data/]
[junit4] 2> 1080222 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 1080280 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1080300 INFO (qtp142085168-3496) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=19
[junit4] 2> 1080316 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 9 attempts
[junit4] 2> 1080316 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1080324 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1080427 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1080427 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1080427 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 10 attempts
[junit4] 2> 1080427 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 1
secs, maxWait 30
[junit4] 2> 1080446 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1080492 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1080492 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1080594 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1080609 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=14
[junit4] 2> 1080609 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 11 attempts
[junit4] 2> 1080609 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 2
secs, maxWait 30
[junit4] 2> 1080609 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1080617 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@68e2786d[timeConfig_shard1_replica_n1] main]
[junit4] 2> 1080638 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/timeConfig
[junit4] 2> 1080638 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/timeConfig
[junit4] 2> 1080638 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at
/configs/timeConfig/managed-schema
[junit4] 2> 1080638 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1080639 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1080639 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.DirectSolrSpellChecker init:
{name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 1080640 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1080640 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
sending requests to Searcher@68e2786d[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1080763 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
done.
[junit4] 2> 1080763 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell
index for spellchecker: default
[junit4] 2> 1080766 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.SolrCore [timeConfig_shard1_replica_n1]
Registered new searcher Searcher@68e2786d[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1080743 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1584422435639263232
[junit4] 2> 1080849 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler expecting overlay version 0 but my version is -1
[junit4] 2> 1080849 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1080850 INFO (SolrConfigHandler-refreshconf)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Another reload is in
progress . Not doing anything
[junit4] 2> 1080869 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Could not get
expectedVersion 0 from
https://127.0.0.1:42358/solr/timeConfig_shard1_replica_n1/ for prop overlay
after 12 attempts
[junit4] 2> 1080869 INFO
(solrHandlerExecutor-1349-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 2
secs, maxWait 30
[junit4] 2> 1080906 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1080906 INFO (Thread-797) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@45447774[timeConfig_shard1_replica_n1] main]
[junit4] 2> 1080926 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
sending requests to Searcher@45447774[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1080926 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener
done.
[junit4] 2> 1080929 INFO
(searcherExecutor-1350-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.c.SolrCore [timeConfig_shard1_replica_n1]
Registered new searcher Searcher@45447774[timeConfig_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1081004 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler I already have the expected version 0 of config
[junit4] 2> 1081004 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 1081004 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={overlay=0&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1081061 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler Took 2606.0ms to set the property overlay to be of
version 0 for collection timeConfig
[junit4] 2> 1081061 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr path=/config
params={wt=javabin&version=2} status=0 QTime=2724
[junit4] 2> 1081061 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.SolrCore [timeConfig_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@a3f5428
[junit4] 2> 1081061 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.timeConfig.shard1.replica_n1, tag=171922472
[junit4] 2> 1081061 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@45c6657c: rootName =
solr_42358, domain = solr.core.timeConfig.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.timeConfig.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@66adf3f2
[junit4] 2> 1081150 INFO (qtp142085168-3498) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.timeConfig.shard1.leader, tag=171922472
[junit4] 2> 1081210 INFO (qtp142085168-3501) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.ZkController Persisted config data to node
/configs/timeConfig/params.json
[junit4] 2> 1081231 INFO (qtp142085168-3501) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler Waiting up to 30 secs for 1 replicas to set the
property params to be of version 1 for collection timeConfig
[junit4] 2> 1081332 INFO (Thread-798) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrCore config update listener called for core
timeConfig_shard1_replica_n1
[junit4] 2> 1081334 INFO (Thread-798) [n:127.0.0.1:42358_solr ]
o.a.s.c.RequestParams conf resource params.json loaded . version : 1
[junit4] 2> 1081334 INFO (Thread-798) [n:127.0.0.1:42358_solr ]
o.a.s.c.RequestParams request params refreshed to version 1
[junit4] 2> 1081341 INFO
(solrHandlerExecutor-1354-thread-1-processing-n:127.0.0.1:42358_solr
x:timeConfig_shard1_replica_n1 s:shard1 c:timeConfig r:core_node2)
[n:127.0.0.1:42358_solr c:timeConfig s:shard1 r:core_node2
x:timeConfig_shard1_replica_n1] o.a.s.h.SolrConfigHandler Time elapsed : 0
secs, maxWait 30
[junit4] 2> 1081480 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler I already have the expected version 1 of params
[junit4] 2> 1081480 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler isStale false , resourceloader
org.apache.solr.cloud.ZkSolrResourceLoader
[junit4] 2> 1081480 INFO (qtp142085168-3499) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.c.S.Request [timeConfig_shard1_replica_n1] webapp=/solr
path=/config/znodeVersion params={params=1&wt=javabin&version=2} status=0
QTime=0
[junit4] 2> 1081634 INFO (qtp142085168-3501) [n:127.0.0.1:42358_solr
c:timeConfig s:shard1 r:core_node2 x:timeConfig_shard1_replica_n1]
o.a.s.h.SolrConfigHandler Took 403.0ms to set the property params to be of
version 1 for collection timeConfig
[junit4] 2> 1081735 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=timeConfig&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1081776 INFO
(OverseerThreadFactory-1339-thread-2-processing-n:127.0.0.1:42358_solr)
[n:127.0.0.1:42358_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1081790 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.timeConfig.shard1.replica_n1, tag=null
[junit4] 2> 1081790 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1efd1b83: rootName =
solr_42358, domain = solr.core.timeConfig.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.timeConfig.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@66adf3f2
[junit4] 2> 1081936 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.c.SolrCore [timeConfig_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@77e06537
[junit4] 2> 1081936 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.timeConfig.shard1.replica_n1, tag=2011194679
[junit4] 2> 1081936 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.timeConfig.shard1.leader, tag=2011194679
[junit4] 2> 1082176 INFO (qtp142085168-3495) [n:127.0.0.1:42358_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=timeConfig_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=385
[junit4] 2> 1082904 INFO (qtp142085168-3502) [n:127.0.0.1:42358_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=timeConfig&action=DELETE&wt=javabin&version=2} status=0 QTime=1169
[junit4] 2> 1082971 INFO (qtp142085168-3500) [n:127.0.0.1:42358_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&property.timePartitionAliasName=myalias&collection.configName=timeConfig&name=myalias_2017-10-23&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[...truncated too long message...]
adApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.core.readApiTestViolations.shard1.replica_n4, tag=2131057063
[junit4] 2> 1176907 INFO (coreCloseExecutor-1552-thread-2)
[n:127.0.0.1:34061_solr c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n4] o.a.s.m.r.SolrJmxReporter Closing
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@372fac9b: rootName
= solr_34061, domain = solr.core.readApiTestViolations.shard1.replica_n4,
service url = null, agent id = null] for registry
solr.core.readApiTestViolations.shard1.replica_n4 /
com.codahale.metrics.MetricRegistry@520c7777
[junit4] 2> 1176945 INFO (jetty-closer-1040-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@28866cfb{/solr,null,UNAVAILABLE}
[junit4] 2> 1176793 WARN
(AutoscalingActionExecutor-1498-thread-1-processing-n:127.0.0.1:40047_solr)
[n:127.0.0.1:40047_solr ] o.a.s.c.a.ScheduledTriggers Exception executing
actions
[junit4] 2> java.lang.Exception: Error executing action: execute_plan for
trigger event: {
[junit4] 2> "id":"14f83b799283e380T4bmms73uj0j68ictp8qthlosa",
[junit4] 2> "source":"node_added_trigger1",
[junit4] 2> "eventTime":1511023068318000000,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1511023068318000000],
[junit4] 2> "_enqueue_time_":1511023068318000000,
[junit4] 2> "nodeNames":["127.0.0.1:34870_solr"]}}
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$2(ScheduledTriggers.java:251)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unexpected
exception while processing event: {
[junit4] 2> "id":"14f83b799283e380T4bmms73uj0j68ictp8qthlosa",
[junit4] 2> "source":"node_added_trigger1",
[junit4] 2> "eventTime":1511023068318000000,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1511023068318000000],
[junit4] 2> "_enqueue_time_":1511023068318000000,
[junit4] 2> "nodeNames":["127.0.0.1:34870_solr"]}}
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:121)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$2(ScheduledTriggers.java:248)
[junit4] 2> ... 6 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unable to
talk to ZooKeeper
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:109)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: java.io.IOException:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request
[junit4] 2> at
org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:111)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.waitForTaskToFinish(ExecutePlanAction.java:133)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:85)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: org.apache.solr.client.solrj.SolrServerException:
No live SolrServers available to handle this request
[junit4] 2> at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460)
[junit4] 2> at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
[junit4] 2> at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
[junit4] 2> at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
[junit4] 2> at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
[junit4] 2> at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
[junit4] 2> at
org.apache.solr.client.solrj.impl.SolrClientCloudManager.request(SolrClientCloudManager.java:109)
[junit4] 2> ... 9 more
[junit4] 2> 1177036 INFO (coreCloseExecutor-1552-thread-2)
[n:127.0.0.1:34061_solr c:readApiTestViolations s:shard1 r:core_node7
x:readApiTestViolations_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.readApiTestViolations.shard1.leader, tag=2131057063
[junit4] 2> 1177129 INFO (coreCloseExecutor-1551-thread-2)
[n:127.0.0.1:40047_solr c:readApiTestViolations s:shard1 r:core_node9
x:readApiTestViolations_shard1_replica_n6] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.readApiTestViolations.shard1.leader, tag=1891830661
[junit4] 2> 1177155 INFO (coreCloseExecutor-1551-thread-3)
[n:127.0.0.1:40047_solr c:readApiTestViolations s:shard1 r:core_node5
x:readApiTestViolations_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.readApiTestViolations.shard1.leader, tag=1428044634
[junit4] 2> 1177620 INFO (jetty-closer-1040-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=99026406204702725-127.0.0.1:40047_solr-n_0000000000) closing
[junit4] 2> 1177620 INFO
(OverseerStateUpdate-99026406204702725-127.0.0.1:40047_solr-n_0000000000)
[n:127.0.0.1:40047_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:40047_solr
[junit4] 2> 1177648 INFO (jetty-closer-1040-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@244dfa64{/solr,null,UNAVAILABLE}
[junit4] 2> 1177692 WARN
(OverseerAutoScalingTriggerThread-99026406204702725-127.0.0.1:40047_solr-n_0000000000)
[n:127.0.0.1:40047_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1177858 INFO (jetty-closer-1040-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7597893b{/solr,null,UNAVAILABLE}
[junit4] 2> 1177963 ERROR
(SUITE-AutoScalingHandlerTest-seed#[76B46F21D3099A38]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1177983 INFO
(SUITE-AutoScalingHandlerTest-seed#[76B46F21D3099A38]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34698 34698
[junit4] 2> 1178058 INFO (Thread-888) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:34698 34698
[junit4] 2> 1178058 WARN (Thread-888) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 193 /solr/aliases.json
[junit4] 2> 193 /solr/clusterprops.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 193 /solr/clusterstate.json
[junit4] 2> 39
/solr/collections/readApiTestViolations/state.json
[junit4] 2> 5 /solr/collections/COLL1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 193 /solr/live_nodes
[junit4] 2> 193 /solr/collections
[junit4] 2> 2 /solr/autoscaling/events/node_added_trigger1
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_76B46F21D3099A38-001
[junit4] 2> Nov 18, 2017 4:38:00 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@52987b60),
locale=lv, timezone=NZ-CHAT
[junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation
1.8.0_152 (64-bit)/cpus=4,threads=1,free=130769392,total=482344960
[junit4] 2> NOTE: All tests run in this JVM: [ImplicitSnitchTest,
BadIndexSchemaTest, TestLegacyField, PrimUtilsTest,
HdfsUnloadDistributedZkTest, ConvertedLegacyTest, TestHashQParserPlugin,
ConfigureRecoveryStrategyTest, TestSurroundQueryParser, MBeansHandlerTest,
TestObjectReleaseTracker, TestDownShardTolerantSearch,
TestSimpleTrackingShardHandler, TestLuceneMatchVersion, OverseerTaskQueueTest,
TestStressReorder, TestRangeQuery, TestOmitPositions,
TestOnReconnectListenerSupport, SolrIndexSplitterTest,
TestDocBasedVersionConstraints, SchemaVersionSpecificBehaviorTest,
HdfsLockFactoryTest, TestJsonFacetRefinement, TestCryptoKeys,
NodeLostTriggerTest, MetricsHandlerTest, TestAnalyzeInfixSuggestions,
PreAnalyzedFieldTest, V2StandaloneTest, TestShortCircuitedRequests,
BasicAuthIntegrationTest, MissingSegmentRecoveryTest, TestOrdValues,
DistributedTermsComponentTest, AnalyticsMergeStrategyTest, RequestHandlersTest,
PathHierarchyTokenizerFactoryTest, DocumentAnalysisRequestHandlerTest,
TestExportWriter, TestConfigSetProperties, SimpleCollectionCreateDeleteTest,
TimePartitionedUpdateProcessorTest, TestSolrConfigHandlerConcurrent,
AutoScalingHandlerTest]
[junit4] Completed [122/750 (2!)] on J1 in 37.30s, 7 tests, 1 failure <<<
FAILURES!
[...truncated 49446 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
