Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.6-Linux/94/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Something is broken in the assert for no shards using the same indexDir -
probably something was changed in the attributes published in the MBean of
SolrCore : {}
Stack Trace:
java.lang.AssertionError: Something is broken in the assert for no shards using
the same indexDir - probably something was changed in the attributes published
in the MBean of SolrCore : {}
at
__randomizedtesting.SeedInfo.seed([9DD4B01A261452B0:D5A1C4AE20277D25]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.checkNoTwoShardsUseTheSameIndexDir(CollectionsAPIDistributedZkTest.java:646)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:524)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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 11626 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/init-core-data-001
[junit4] 2> 527913 WARN
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=44 numCloses=44
[junit4] 2> 527913 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 527914 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 527915 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001
[junit4] 2> 527915 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 527915 INFO (Thread-3179) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 527915 INFO (Thread-3179) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 527916 ERROR (Thread-3179) [ ] 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> 528015 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:43593
[junit4] 2> 528020 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e1a60ab5a0000, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 528042 INFO (jetty-launcher-889-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 528043 INFO (jetty-launcher-889-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 528044 INFO (jetty-launcher-889-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 528044 INFO (jetty-launcher-889-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 528044 INFO (jetty-launcher-889-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@462c3c19{/solr,null,AVAILABLE}
[junit4] 2> 528046 INFO (jetty-launcher-889-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@60db9950{/solr,null,AVAILABLE}
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6b0b1b1f{SSL,[ssl,
http/1.1]}{127.0.0.1:45469}
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.e.j.s.Server Started @530070ms
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45469}
[junit4] 2> 528048 ERROR (jetty-launcher-889-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.1
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 528048 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-08-25T17:11:36.670Z
[junit4] 2> 528055 INFO (jetty-launcher-889-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@612bb9a1{/solr,null,AVAILABLE}
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@65750cfc{SSL,[ssl,
http/1.1]}{127.0.0.1:45211}
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.e.j.s.Server Started @530078ms
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45211}
[junit4] 2> 528056 ERROR (jetty-launcher-889-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.1
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 528056 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-08-25T17:11:36.678Z
[junit4] 2> 528058 INFO (jetty-launcher-889-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@712034a3{SSL,[ssl,
http/1.1]}{127.0.0.1:35351}
[junit4] 2> 528058 INFO (jetty-launcher-889-thread-2) [ ]
o.e.j.s.Server Started @530080ms
[junit4] 2> 528058 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35351}
[junit4] 2> 528059 ERROR (jetty-launcher-889-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 528059 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.1
[junit4] 2> 528059 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 528059 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 528059 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-08-25T17:11:36.681Z
[junit4] 2> 528060 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 528065 INFO (jetty-launcher-889-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@287f97d9{/solr,null,AVAILABLE}
[junit4] 2> 528066 INFO (jetty-launcher-889-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2d7b976d{SSL,[ssl,
http/1.1]}{127.0.0.1:41407}
[junit4] 2> 528066 INFO (jetty-launcher-889-thread-4) [ ]
o.e.j.s.Server Started @530088ms
[junit4] 2> 528066 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41407}
[junit4] 2> 528067 ERROR (jetty-launcher-889-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 528067 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.1
[junit4] 2> 528067 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 528067 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 528067 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-08-25T17:11:36.689Z
[junit4] 2> 528067 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 528073 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 528073 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 528073 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 528074 INFO (jetty-launcher-889-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43593/solr
[junit4] 2> 528080 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 528081 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 528081 INFO (jetty-launcher-889-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43593/solr
[junit4] 2> 528081 INFO (jetty-launcher-889-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43593/solr
[junit4] 2> 528087 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 528089 INFO (jetty-launcher-889-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43593/solr
[junit4] 2> 528099 INFO (jetty-launcher-889-thread-3)
[n:127.0.0.1:45469_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 528099 INFO (jetty-launcher-889-thread-3)
[n:127.0.0.1:45469_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45469_solr
[junit4] 2> 528100 INFO (jetty-launcher-889-thread-3)
[n:127.0.0.1:45469_solr ] o.a.s.c.Overseer Overseer
(id=98545244342714376-127.0.0.1:45469_solr-n_0000000000) starting
[junit4] 2> 528108 INFO (jetty-launcher-889-thread-2)
[n:127.0.0.1:35351_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 528109 INFO (jetty-launcher-889-thread-2)
[n:127.0.0.1:35351_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35351_solr
[junit4] 2> 528116 INFO (jetty-launcher-889-thread-1)
[n:127.0.0.1:45211_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 528117 INFO (jetty-launcher-889-thread-1)
[n:127.0.0.1:45211_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 528117 INFO (jetty-launcher-889-thread-1)
[n:127.0.0.1:45211_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45211_solr
[junit4] 2> 528125 INFO (jetty-launcher-889-thread-3)
[n:127.0.0.1:45469_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45469_solr
[junit4] 2> 528134 INFO
(zkCallback-906-thread-1-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 528135 INFO
(zkCallback-909-thread-1-processing-n:127.0.0.1:35351_solr)
[n:127.0.0.1:35351_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 528135 INFO
(OverseerStateUpdate-98545244342714376-127.0.0.1:45469_solr-n_0000000000)
[n:127.0.0.1:45469_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 528138 INFO (jetty-launcher-889-thread-4)
[n:127.0.0.1:41407_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 528138 INFO (jetty-launcher-889-thread-4)
[n:127.0.0.1:41407_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 528139 INFO (jetty-launcher-889-thread-4)
[n:127.0.0.1:41407_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41407_solr
[junit4] 2> 528140 INFO
(zkCallback-906-thread-2-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 528143 INFO
(zkCallback-912-thread-1-processing-n:127.0.0.1:41407_solr)
[n:127.0.0.1:41407_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 528143 INFO
(zkCallback-909-thread-2-processing-n:127.0.0.1:35351_solr)
[n:127.0.0.1:35351_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 528143 INFO
(zkCallback-910-thread-1-processing-n:127.0.0.1:45211_solr)
[n:127.0.0.1:45211_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (4)
[junit4] 2> 528151 INFO (jetty-launcher-889-thread-2)
[n:127.0.0.1:35351_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node4/.
[junit4] 2> 528185 INFO (jetty-launcher-889-thread-3)
[n:127.0.0.1:45469_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node2/.
[junit4] 2> 528186 INFO (jetty-launcher-889-thread-1)
[n:127.0.0.1:45211_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node1/.
[junit4] 2> 528218 INFO (jetty-launcher-889-thread-4)
[n:127.0.0.1:41407_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node3/.
[junit4] 2> 528223 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 528224 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43593/solr ready
[junit4] 2> 528253 INFO
(TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[9DD4B01A261452B0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testTooManyReplicas
[junit4] 2> 528253 INFO
(TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[9DD4B01A261452B0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 528312 INFO (qtp384063131-7119) [n:127.0.0.1:35351_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 528317 INFO
(OverseerThreadFactory-2646-thread-1-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection
[junit4] 2> 528317 WARN
(OverseerThreadFactory-2646-thread-1-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.CreateCollectionCmd Specified
replicationFactor of 10 on collection collection is higher than or equal to the
number of Solr instances currently live or live and part of your
createNodeSet(4). It's unusual to run two replica of the same slice on the same
Solr-instance.
[junit4] 2> 528317 ERROR
(OverseerThreadFactory-2646-thread-1-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.OverseerCollectionMessageHandler
Collection: collection operation: create
failed:org.apache.solr.common.SolrException: Cannot create collection
collection. Value of maxShardsPerNode is 1, and the number of nodes currently
live or live and part of your createNodeSet is 4. This allows a maximum of 4 to
be created. Value of numShards is 2 and value of replicationFactor is 10. This
requires 20 shards to be created (higher than the allowed number)
[junit4] 2> at
org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:155)
[junit4] 2> at
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226)
[junit4] 2> at
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[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>
[junit4] 2> 528328 INFO (qtp384063131-7119) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2}
status=400 QTime=16
[junit4] 2> 528330 INFO
(TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[9DD4B01A261452B0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testTooManyReplicas
[junit4] 2> 528354 INFO
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[9DD4B01A261452B0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet
[junit4] 2> 528354 INFO
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[9DD4B01A261452B0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 528357 INFO (qtp384063131-7125) [n:127.0.0.1:35351_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:45211/solr,https://127.0.0.1:45469/solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 528358 INFO
(OverseerThreadFactory-2646-thread-2-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.CreateCollectionCmd Create collection
nodeset_collection
[junit4] 2> 528358 INFO
(OverseerCollectionConfigSetProcessor-98545244342714376-127.0.0.1:45469_solr-n_0000000000)
[n:127.0.0.1:45469_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> 528358 WARN
(OverseerThreadFactory-2646-thread-2-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.CreateCollectionCmd It is unusual to
create a collection (nodeset_collection) without cores.
[junit4] 2> 528461 INFO (qtp384063131-7125) [n:127.0.0.1:35351_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> 528462 INFO (qtp384063131-7125) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:45211/solr,https://127.0.0.1:45469/solr&wt=javabin&version=2}
status=0 QTime=104
[junit4] 2> 528462 INFO
(TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[9DD4B01A261452B0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet
[junit4] 2> 528485 INFO
(TEST-CollectionsAPIDistributedZkTest.testCollectionsAPI-seed#[9DD4B01A261452B0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionsAPI
[junit4] 2> 528486 INFO
(TEST-CollectionsAPIDistributedZkTest.testCollectionsAPI-seed#[9DD4B01A261452B0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 528488 INFO (qtp384063131-7126) [n:127.0.0.1:35351_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=nodeset_collection&action=DELETE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 528490 INFO
(OverseerCollectionConfigSetProcessor-98545244342714376-127.0.0.1:45469_solr-n_0000000000)
[n:127.0.0.1:45469_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 528490 INFO
(OverseerThreadFactory-2646-thread-3-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 529193 INFO (qtp384063131-7126) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=nodeset_collection&action=DELETE&wt=javabin&version=2} status=0
QTime=704
[junit4] 2> 529194 INFO (qtp384063131-7120) [n:127.0.0.1:35351_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d8&replicationFactor=4&collection.configName=conf2&maxShardsPerNode=3&name=awhollynewcollection_0&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 529195 INFO (qtp384063131-7120) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d8&replicationFactor=4&collection.configName=conf2&maxShardsPerNode=3&name=awhollynewcollection_0&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529196 INFO
(OverseerThreadFactory-2646-thread-4-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.CreateCollectionCmd Create collection
awhollynewcollection_0
[junit4] 2> 529196 INFO
(OverseerCollectionConfigSetProcessor-98545244342714376-127.0.0.1:45469_solr-n_0000000000)
[n:127.0.0.1:45469_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 529298 INFO (zkCallback-919-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeCreated
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 529422 INFO (qtp384063131-7124) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica4&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 529422 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica4&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 529422 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 529423 INFO (qtp384063131-7125) [n:127.0.0.1:35351_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica4&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 529424 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica4&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2
[junit4] 2> 529454 INFO (qtp556525585-7132) [n:127.0.0.1:45469_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica2&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529454 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica2&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2
[junit4] 2> 529455 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 529468 INFO (qtp1272079680-7152) [n:127.0.0.1:45211_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica3&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529468 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica3&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 529468 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 529472 INFO (qtp1272079680-7129) [n:127.0.0.1:45211_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica3&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529472 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica3&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2
[junit4] 2> 529476 INFO (qtp556525585-7131) [n:127.0.0.1:45469_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica2&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529476 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica2&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 529479 INFO (qtp1935959068-7143) [n:127.0.0.1:41407_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica1&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529482 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard1_replica1&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard1&wt=javabin&version=2
[junit4] 2> 529488 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 529498 INFO (qtp1935959068-7144) [n:127.0.0.1:41407_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica1&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529498 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr ] o.a.s.h.a.CoreAdminOperation core create command
async=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390&qt=/admin/cores&collection.configName=conf2&newCollection=true&name=awhollynewcollection_0_shard2_replica1&action=CREATE&numShards=2&collection=awhollynewcollection_0&shard=shard2&wt=javabin&version=2
[junit4] 2> 529501 INFO (qtp556525585-7133) [n:127.0.0.1:45469_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588
[junit4] 2> 529501 INFO (qtp556525585-7133) [n:127.0.0.1:45469_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 529602 INFO
(zkCallback-912-thread-1-processing-n:127.0.0.1:41407_solr)
[n:127.0.0.1:41407_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 529602 INFO
(zkCallback-906-thread-2-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 529602 INFO (zkCallback-919-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 529602 INFO
(zkCallback-909-thread-2-processing-n:127.0.0.1:35351_solr)
[n:127.0.0.1:35351_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 529606 INFO
(zkCallback-910-thread-1-processing-n:127.0.0.1:45211_solr)
[n:127.0.0.1:45211_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/awhollynewcollection_0/state.json] for collection
[awhollynewcollection_0] has occurred - updating... (live nodes size: [4])
[junit4] 2> 530434 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530436 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530456 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard2_replica4] Schema name=minimal
[junit4] 2> 530457 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard1_replica4] Schema name=minimal
[junit4] 2> 530459 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530459 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard1_replica4' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530459 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530459 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard1_replica4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node4/awhollynewcollection_0_shard1_replica4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node4/./awhollynewcollection_0_shard1_replica4/data/]
[junit4] 2> 530462 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530462 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530462 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard2_replica4' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530462 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530462 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard2_replica4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node4/awhollynewcollection_0_shard2_replica4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node4/./awhollynewcollection_0_shard2_replica4/data/]
[junit4] 2> 530467 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard1_replica2] Schema name=minimal
[junit4] 2> 530468 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530468 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard1_replica2' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530469 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530469 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard1_replica2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node2/awhollynewcollection_0_shard1_replica2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node2/./awhollynewcollection_0_shard1_replica2/data/]
[junit4] 2> 530485 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530485 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530486 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530486 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530487 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7de6cf80[awhollynewcollection_0_shard2_replica4] main]
[junit4] 2> 530487 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530487 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530488 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530488 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530488 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2160b8ea[awhollynewcollection_0_shard1_replica4] main]
[junit4] 2> 530490 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530490 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912183513088
[junit4] 2> 530491 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912183513088
[junit4] 2> 530492 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530493 INFO
(searcherExecutor-2655-thread-1-processing-x:awhollynewcollection_0_shard1_replica4
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE
n:127.0.0.1:35351_solr s:shard1 c:awhollynewcollection_0)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.SolrCore
[awhollynewcollection_0_shard1_replica4] Registered new searcher
Searcher@2160b8ea[awhollynewcollection_0_shard1_replica4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530494 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530494 INFO
(searcherExecutor-2656-thread-1-processing-x:awhollynewcollection_0_shard2_replica4
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE
n:127.0.0.1:35351_solr s:shard2 c:awhollynewcollection_0)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.SolrCore
[awhollynewcollection_0_shard2_replica4] Registered new searcher
Searcher@7de6cf80[awhollynewcollection_0_shard2_replica4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530504 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530506 INFO
(parallelCoreAdminExecutor-2647-thread-2-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024793455 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica4] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard1: total=4 found=1
timeoutin=9999ms
[junit4] 2> 530506 INFO
(parallelCoreAdminExecutor-2647-thread-1-processing-n:127.0.0.1:35351_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024887581 CREATE)
[n:127.0.0.1:35351_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica4] o.a.s.c.ShardLeaderElectionContext
Waiting until we see more replicas up for shard shard2: total=4 found=1
timeoutin=9999ms
[junit4] 2> 530508 INFO (qtp556525585-7132) [n:127.0.0.1:45469_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588
[junit4] 2> 530508 INFO (qtp556525585-7132) [n:127.0.0.1:45469_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 530508 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard1_replica3] Schema name=minimal
[junit4] 2> 530510 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard2_replica2] Schema name=minimal
[junit4] 2> 530510 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530510 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530510 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard1_replica3' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530511 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530511 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard1_replica3] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node1/awhollynewcollection_0_shard1_replica3],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node1/./awhollynewcollection_0_shard1_replica3/data/]
[junit4] 2> 530512 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530513 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard2_replica2' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530513 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530513 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard2_replica2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node2/awhollynewcollection_0_shard2_replica2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node2/./awhollynewcollection_0_shard2_replica2/data/]
[junit4] 2> 530515 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 6.6.1
[junit4] 2> 530522 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530522 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530523 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530523 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530524 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4cbc1767[awhollynewcollection_0_shard1_replica2] main]
[junit4] 2> 530525 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard2_replica1] Schema name=minimal
[junit4] 2> 530525 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard2_replica3] Schema name=minimal
[junit4] 2> 530527 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530560 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard2_replica1' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard2_replica3' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard2_replica1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node3/awhollynewcollection_0_shard2_replica1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node3/./awhollynewcollection_0_shard2_replica1/data/]
[junit4] 2> 530561 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard2_replica3] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node1/awhollynewcollection_0_shard2_replica3],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node1/./awhollynewcollection_0_shard2_replica3/data/]
[junit4] 2> 530562 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530562 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530563 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530563 INFO
(searcherExecutor-2657-thread-1-processing-x:awhollynewcollection_0_shard1_replica2
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE
n:127.0.0.1:45469_solr s:shard1 c:awhollynewcollection_0)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.c.SolrCore
[awhollynewcollection_0_shard1_replica2] Registered new searcher
Searcher@4cbc1767[awhollynewcollection_0_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530563 INFO
(parallelCoreAdminExecutor-2649-thread-1-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024280588 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912259010560
[junit4] 2> 530563 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.s.IndexSchema
[awhollynewcollection_0_shard1_replica1] Schema name=minimal
[junit4] 2> 530565 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 530565 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.c.CoreContainer Creating
SolrCore 'awhollynewcollection_0_shard1_replica1' using configuration from
collection awhollynewcollection_0, trusted=true
[junit4] 2> 530565 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 530565 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.c.SolrCore
[[awhollynewcollection_0_shard1_replica1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node3/awhollynewcollection_0_shard1_replica1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001/tempDir-001/node3/./awhollynewcollection_0_shard1_replica1/data/]
[junit4] 2> 530575 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530575 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530575 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530575 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530576 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530576 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530576 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530576 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530577 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.s.SolrIndexSearcher Opening
[Searcher@26d19f09[awhollynewcollection_0_shard1_replica3] main]
[junit4] 2> 530577 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@8e1c793[awhollynewcollection_0_shard2_replica2] main]
[junit4] 2> 530577 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2649-thread-2-processing-n:127.0.0.1:45469_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912274739200
[junit4] 2> 530578 INFO
(searcherExecutor-2667-thread-1-processing-x:awhollynewcollection_0_shard2_replica2
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024074223 CREATE
n:127.0.0.1:45469_solr s:shard2 c:awhollynewcollection_0)
[n:127.0.0.1:45469_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica2] o.a.s.c.SolrCore
[awhollynewcollection_0_shard2_replica2] Registered new searcher
Searcher@8e1c793[awhollynewcollection_0_shard2_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530578 INFO
(parallelCoreAdminExecutor-2650-thread-2-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912274739200
[junit4] 2> 530578 INFO
(searcherExecutor-2666-thread-1-processing-x:awhollynewcollection_0_shard1_replica3
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024962152 CREATE
n:127.0.0.1:45211_solr s:shard1 c:awhollynewcollection_0)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica3] o.a.s.c.SolrCore
[awhollynewcollection_0_shard1_replica3] Registered new searcher
Searcher@26d19f09[awhollynewcollection_0_shard1_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530592 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530592 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530592 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530592 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4fec948f[awhollynewcollection_0_shard2_replica3] main]
[junit4] 2> 530593 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@17735232[awhollynewcollection_0_shard2_replica1] main]
[junit4] 2> 530594 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2650-thread-1-processing-n:127.0.0.1:45211_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912292564992
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530595 INFO
(parallelCoreAdminExecutor-2653-thread-2-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912292564992
[junit4] 2> 530596 INFO
(searcherExecutor-2673-thread-1-processing-x:awhollynewcollection_0_shard2_replica3
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025133625 CREATE
n:127.0.0.1:45211_solr s:shard2 c:awhollynewcollection_0)
[n:127.0.0.1:45211_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica3] o.a.s.c.SolrCore
[awhollynewcollection_0_shard2_replica3] Registered new searcher
Searcher@4fec948f[awhollynewcollection_0_shard2_replica3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530598 INFO
(searcherExecutor-2672-thread-1-processing-x:awhollynewcollection_0_shard2_replica1
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021025070390 CREATE
n:127.0.0.1:41407_solr s:shard2 c:awhollynewcollection_0)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard2
x:awhollynewcollection_0_shard2_replica1] o.a.s.c.SolrCore
[awhollynewcollection_0_shard2_replica1] Registered new searcher
Searcher@17735232[awhollynewcollection_0_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530599 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 530599 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 530600 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 530600 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 530600 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2e3cd487[awhollynewcollection_0_shard1_replica1] main]
[junit4] 2> 530600 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf2
[junit4] 2> 530601 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf2
[junit4] 2> 530601 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000
[junit4] 2> 530601 INFO
(searcherExecutor-2674-thread-1-processing-x:awhollynewcollection_0_shard1_replica1
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE
n:127.0.0.1:41407_solr s:shard1 c:awhollynewcollection_0)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.c.SolrCore
[awhollynewcollection_0_shard1_replica1] Registered new searcher
Searcher@2e3cd487[awhollynewcollection_0_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 530601 INFO
(parallelCoreAdminExecutor-2653-thread-1-processing-n:127.0.0.1:41407_solr
159b23e3-628f-4fb7-8ea7-1007ef05a6d82678021024203875 CREATE)
[n:127.0.0.1:41407_solr c:awhollynewcollection_0 s:shard1
x:awhollynewcollection_0_shard1_replica1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1576723912298856448
[junit4] 2> 530667 INFO (zkCallback-919-thread-4
[...truncated too long message...]
he.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:748)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:729)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:510)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:361)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:305)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:136)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 620430 INFO (qtp556525585-7117) [n:127.0.0.1:45469_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:35351_solr&onlyIfLeaderActive=true&core=addReplicaColl_shard1_replica1&coreNodeName=core_node7&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=400 QTime=8003
[junit4] 2> 621113 WARN
(zkCallback-909-thread-1-processing-n:127.0.0.1:35351_solr)
[n:127.0.0.1:35351_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 621113 INFO (jetty-closer-890-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@462c3c19{/solr,null,UNAVAILABLE}
[junit4] 2> 621114 WARN
(zkCallback-910-thread-2-processing-n:127.0.0.1:45211_solr)
[n:127.0.0.1:45211_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 621115 INFO (jetty-closer-890-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@612bb9a1{/solr,null,UNAVAILABLE}
[junit4] 2> 621127 WARN
(zkCallback-906-thread-1-processing-n:127.0.0.1:45469_solr)
[n:127.0.0.1:45469_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 621128 INFO (jetty-closer-890-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@60db9950{/solr,null,UNAVAILABLE}
[junit4] 2> 621128 ERROR
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-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> 621128 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:43593 43593
[junit4] 2> 621134 INFO (Thread-3179) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:43593 43593
[junit4] 2> 621135 WARN (Thread-3179) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 25 /solr/aliases.json
[junit4] 2> 23 /solr/configs/conf
[junit4] 2> 5 /solr/configs/conf2
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 230 /solr/clusterstate.json
[junit4] 2> 25 /solr/clusterprops.json
[junit4] 2> 5
/solr/collections/awhollynewcollection_0/state.json
[junit4] 2> 4
/solr/collections/nodes_used_collection/state.json
[junit4] 2> 4 /solr/collections/addReplicaColl/state.json
[junit4] 2> 4 /solr/collections/reloaded_collection/state.json
[junit4] 2> 3
/solr/overseer_elect/election/98545244342714376-127.0.0.1:45469_solr-n_0000000000
[junit4] 2> 3
/solr/collections/acollectionafterbaddelete/state.json
[junit4] 2> 3
/solr/collections/awhollynewcollection_0/leader_elect/shard2/election/98545244342714378-core_node2-n_0000000000
[junit4] 2> 2 /solr/collections/onlyinzk/state.json
[junit4] 2> 2
/solr/collections/halfdeletedcollection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 366 /solr/collections
[junit4] 2> 25 /solr/live_nodes
[junit4] 2>
[junit4] 2> 621135 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[9DD4B01A261452B0]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-6.6-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_9DD4B01A261452B0-001
[junit4] 2> Aug 25, 2017 5:13:09 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=Asserting(Lucene62):
{_version_=PostingsFormat(name=Memory doPackFST= false), id=FST50},
docValues:{}, maxPointsInLeafNode=740, maxMBSortInHeap=7.688439842231739,
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=sr-Latn-ME,
timezone=Africa/Porto-Novo
[junit4] 2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=8,threads=1,free=208499320,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestCollapseQParserPlugin,
JsonLoaderTest, UUIDUpdateProcessorFallbackTest, TestTrie,
SolrCoreMetricManagerTest, TestQueryUtils, DocumentBuilderTest, CursorMarkTest,
HdfsWriteToMultipleCollectionsTest, TestRestManager,
TestLMDirichletSimilarityFactory, TestCollectionAPIs, TestTestInjection,
TestShardHandlerFactory, TestSolrCoreSnapshots, TestDistribIDF,
TestHashPartitioner, CheckHdfsIndexTest, TestCollationFieldDocValues,
SolrJmxReporterCloudTest, TestFastOutputStream, TestMaxScoreQueryParser,
PreAnalyzedFieldManagedSchemaCloudTest, TestTrieFacet, TestFiltering,
MultiTermTest, DistributedFacetPivotLargeTest, TestCSVResponseWriter,
TestLuceneMatchVersion, TestCustomDocTransformer,
TestRuleBasedAuthorizationPlugin, TestCustomSort, SolrCloudExampleTest,
TestTrackingShardHandlerFactory, TestDistributedGrouping,
ClusterStateUpdateTest, ZkControllerTest, RankQueryTest,
TestQuerySenderListener, BlockCacheTest, CdcrRequestHandlerTest,
ConnectionManagerTest, DirectSolrSpellCheckerTest,
WordBreakSolrSpellCheckerTest, TestSolrQueryParserDefaultOperatorResource,
TestStressCloudBlindAtomicUpdates, ConnectionReuseTest, EchoParamsTest,
TestRandomRequestDistribution, RestartWhileUpdatingTest,
TestGraphTermsQParserPlugin, TestSolrCloudWithDelegationTokens,
TestDFISimilarityFactory, OpenCloseCoreStressTest, MetricsHandlerTest,
CSVRequestHandlerTest, TestNoOpRegenerator, TestPartialUpdateDeduplication,
CleanupOldIndexTest, SmileWriterTest, SolrIndexSplitterTest, TestSchemaManager,
TestChildDocTransformer, TestSystemCollAutoCreate,
TestPayloadScoreQParserPlugin, TestCoreContainer, AssignTest,
TestFieldCollectionResource, TestSolrFieldCacheMBean, TestConfigReload,
TestSchemaSimilarityResource, TestSuggestSpellingConverter, SuggesterFSTTest,
DistanceFunctionTest, TestSurroundQueryParser, TestOrdValues, TestQueryTypes,
TestFileDictionaryLookup, SpatialFilterTest, ConvertedLegacyTest,
DistributedMLTComponentTest, BlockJoinFacetDistribTest,
PeerSyncWithIndexFingerprintCachingTest, SpatialHeatmapFacetsTest,
CollectionsAPIDistributedZkTest]
[junit4] Completed [201/713 (1!)] on J1 in 93.49s, 20 tests, 1 failure <<<
FAILURES!
[...truncated 45139 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
