Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-MacOSX/843/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED:
org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter
Error Message:
Collection not found: withShardField
Stack Trace:
org.apache.solr.common.SolrException: Collection not found: withShardField
at
__randomizedtesting.SeedInfo.seed([1665D046525E1607:433538D4FEA7D9F7]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.getCollectionNames(CloudSolrClient.java:1401)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1094)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1073)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at
org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233)
at
org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter(CustomCollectionTest.java:141)
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:745)
Build Log:
[...truncated 11295 lines...]
[junit4] Suite: org.apache.solr.cloud.CustomCollectionTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/init-core-data-001
[junit4] 2> 241809 WARN
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
[junit4] 2> 241809 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 241813 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
w/ MAC_OS_X supressed clientAuth
[junit4] 2> 241815 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001
[junit4] 2> 241815 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 241815 INFO (Thread-514) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 241816 INFO (Thread-514) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 241819 ERROR (Thread-514) [ ] 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> 241916 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:64566
[junit4] 2> 241968 INFO (jetty-launcher-228-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 241968 INFO (jetty-launcher-228-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 241969 INFO (jetty-launcher-228-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 241970 INFO (jetty-launcher-228-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 241973 INFO (jetty-launcher-228-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3ade8ff7{/solr,null,AVAILABLE}
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6ede2482{SSL,[ssl,
http/1.1]}{127.0.0.1:64568}
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1622e4d8{/solr,null,AVAILABLE}
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.e.j.s.Server Started @247608ms
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64568}
[junit4] 2> 241974 ERROR (jetty-launcher-228-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 241974 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-01T14:34:35.102Z
[junit4] 2> 241975 INFO (jetty-launcher-228-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7c6da409{/solr,null,AVAILABLE}
[junit4] 2> 241977 INFO (jetty-launcher-228-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7b7487b1{SSL,[ssl,
http/1.1]}{127.0.0.1:64569}
[junit4] 2> 241977 INFO (jetty-launcher-228-thread-1) [ ]
o.e.j.s.Server Started @247611ms
[junit4] 2> 241977 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64569}
[junit4] 2> 241977 ERROR (jetty-launcher-228-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-01T14:34:35.106Z
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1420088e{SSL,[ssl,
http/1.1]}{127.0.0.1:64570}
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-3) [ ]
o.e.j.s.Server Started @247612ms
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64570}
[junit4] 2> 241978 ERROR (jetty-launcher-228-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 241978 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 241979 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 241979 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 241979 INFO (jetty-launcher-228-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7613b8a8{/solr,null,AVAILABLE}
[junit4] 2> 241979 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-01T14:34:35.107Z
[junit4] 2> 241982 INFO (jetty-launcher-228-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@70c857ee{SSL,[ssl,
http/1.1]}{127.0.0.1:64571}
[junit4] 2> 241982 INFO (jetty-launcher-228-thread-2) [ ]
o.e.j.s.Server Started @247616ms
[junit4] 2> 241982 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=64571}
[junit4] 2> 241983 ERROR (jetty-launcher-228-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 241984 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 241984 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 241985 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 241985 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-01T14:34:35.113Z
[junit4] 2> 241990 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 241991 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 241991 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 242002 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 242007 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 0x15bc46f38420003, 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:745)
[junit4] 2> 242011 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 242011 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 242012 INFO (jetty-launcher-228-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64566/solr
[junit4] 2> 242013 INFO (jetty-launcher-228-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64566/solr
[junit4] 2> 242018 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 0x15bc46f38420004, 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:745)
[junit4] 2> 242020 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 242020 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 242023 INFO (jetty-launcher-228-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64566/solr
[junit4] 2> 242023 INFO (jetty-launcher-228-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64566/solr
[junit4] 2> 242031 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 0x15bc46f38420006, 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:745)
[junit4] 2> 242036 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 0x15bc46f38420007, 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:745)
[junit4] 2> 242039 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 0x15bc46f38420008, 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:745)
[junit4] 2> 242093 INFO (jetty-launcher-228-thread-4)
[n:127.0.0.1:64568_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 242094 INFO (jetty-launcher-228-thread-2)
[n:127.0.0.1:64571_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 242094 INFO (jetty-launcher-228-thread-3)
[n:127.0.0.1:64570_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 242094 INFO (jetty-launcher-228-thread-1)
[n:127.0.0.1:64569_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 242096 INFO (jetty-launcher-228-thread-4)
[n:127.0.0.1:64568_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:64568_solr
[junit4] 2> 242097 INFO (jetty-launcher-228-thread-2)
[n:127.0.0.1:64571_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64571_solr
[junit4] 2> 242097 INFO (jetty-launcher-228-thread-3)
[n:127.0.0.1:64570_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64570_solr
[junit4] 2> 242097 INFO (jetty-launcher-228-thread-1)
[n:127.0.0.1:64569_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64569_solr
[junit4] 2> 242099 INFO (jetty-launcher-228-thread-4)
[n:127.0.0.1:64568_solr ] o.a.s.c.Overseer Overseer
(id=97887798882861065-127.0.0.1:64568_solr-n_0000000000) starting
[junit4] 2> 242102 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 242102 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 242103 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 242103 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 242166 INFO (jetty-launcher-228-thread-4)
[n:127.0.0.1:64568_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64568_solr
[junit4] 2> 242170 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 242170 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 242170 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 242170 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 242594 INFO (jetty-launcher-228-thread-3)
[n:127.0.0.1:64570_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node3/.
[junit4] 2> 242600 INFO (jetty-launcher-228-thread-4)
[n:127.0.0.1:64568_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node4/.
[junit4] 2> 242603 INFO (jetty-launcher-228-thread-1)
[n:127.0.0.1:64569_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node1/.
[junit4] 2> 242608 INFO (jetty-launcher-228-thread-2)
[n:127.0.0.1:64571_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node2/.
[junit4] 2> 242965 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 242967 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:64566/solr ready
[junit4] 2> 243008 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[1665D046525E1607])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForHashRouter
[junit4] 2> 243011 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[1665D046525E1607])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 243045 INFO (qtp1249989868-1642) [n:127.0.0.1:64571_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=routeFieldColl&action=CREATE&numShards=4&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 243049 INFO
(OverseerThreadFactory-971-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.CreateCollectionCmd Create collection
routeFieldColl
[junit4] 2> 243233 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 243233 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 243235 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2
[junit4] 2> 243249 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 243250 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 243254 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2
[junit4] 2> 243254 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 243254 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 243255 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 243257 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 243258 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2
[junit4] 2> 243260 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2
[junit4] 2> 243390 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 243390 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 243390 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 243390 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 244284 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244284 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244298 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica2] Schema name=cloud-dynamic
[junit4] 2> 244303 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica2] Schema name=cloud-dynamic
[junit4] 2> 244327 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244334 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244343 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica1] Schema name=cloud-dynamic
[junit4] 2> 244359 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica1] Schema name=cloud-dynamic
[junit4] 2> 244385 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244388 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244389 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244392 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 244398 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica2] Schema name=cloud-dynamic
[junit4] 2> 244399 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica1] Schema name=cloud-dynamic
[junit4] 2> 244419 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica2] Schema name=cloud-dynamic
[junit4] 2> 244421 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica1] Schema name=cloud-dynamic
[junit4] 2> 244467 WARN (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica2] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244471 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244471 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica2' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244471 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244472 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore
[[routeFieldColl_shard4_replica2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node2/routeFieldColl_shard4_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node2/./routeFieldColl_shard4_replica2/data/]
[junit4] 2> 244474 WARN (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica2] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244474 WARN (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244474 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244474 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica2' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244475 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244475 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244475 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore
[[routeFieldColl_shard3_replica2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node3/routeFieldColl_shard3_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node3/./routeFieldColl_shard3_replica2/data/]
[junit4] 2> 244475 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica1' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244475 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244475 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore
[[routeFieldColl_shard2_replica1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node1/routeFieldColl_shard2_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node1/./routeFieldColl_shard2_replica1/data/]
[junit4] 2> 244484 WARN (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica2] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244499 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244499 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica2' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244499 WARN (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244499 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244499 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
[[routeFieldColl_shard1_replica2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node3/routeFieldColl_shard1_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node3/./routeFieldColl_shard1_replica2/data/]
[junit4] 2> 244499 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244499 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard4_replica1' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244500 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244500 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore
[[routeFieldColl_shard4_replica1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node1/routeFieldColl_shard4_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node1/./routeFieldColl_shard4_replica1/data/]
[junit4] 2> 244501 WARN (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica2] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244502 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244502 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard2_replica2' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244502 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244502 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore
[[routeFieldColl_shard2_replica2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node2/routeFieldColl_shard2_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node2/./routeFieldColl_shard2_replica2/data/]
[junit4] 2> 244503 WARN (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244503 WARN (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 244503 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244503 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard1_replica1' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244504 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 244504 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244504 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'routeFieldColl_shard3_replica1' using
configuration from collection routeFieldColl, trusted=true
[junit4] 2> 244504 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 244504 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore
[[routeFieldColl_shard3_replica1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node4/routeFieldColl_shard3_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node4/./routeFieldColl_shard3_replica1/data/]
[junit4] 2> 244505 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
[[routeFieldColl_shard1_replica1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node4/routeFieldColl_shard1_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001/tempDir-001/node4/./routeFieldColl_shard1_replica1/data/]
[junit4] 2> 244699 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244699 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244703 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244704 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244704 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244704 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244709 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244710 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244712 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244712 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244714 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244714 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244714 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244714 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244716 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244716 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244727 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7bd285a6[routeFieldColl_shard2_replica1] main]
[junit4] 2> 244729 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244729 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244730 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244731 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@38d83235[routeFieldColl_shard1_replica1] main]
[junit4] 2> 244731 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244732 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244733 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244733 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244733 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244733 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244734 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244734 INFO
(searcherExecutor-986-thread-1-processing-n:127.0.0.1:64568_solr
x:routeFieldColl_shard1_replica1 s:shard1 c:routeFieldColl)
[n:127.0.0.1:64568_solr c:routeFieldColl s:shard1
x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica1] Registered new searcher
Searcher@38d83235[routeFieldColl_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244734 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785183424512
[junit4] 2> 244734 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244734 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244734 INFO
(searcherExecutor-982-thread-1-processing-n:127.0.0.1:64569_solr
x:routeFieldColl_shard2_replica1 s:shard2 c:routeFieldColl)
[n:127.0.0.1:64569_solr c:routeFieldColl s:shard2
x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard2_replica1] Registered new searcher
Searcher@7bd285a6[routeFieldColl_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244734 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785183424512
[junit4] 2> 244735 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244735 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244738 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@67c27359[routeFieldColl_shard2_replica2] main]
[junit4] 2> 244741 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244742 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244742 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244742 INFO
(searcherExecutor-985-thread-1-processing-n:127.0.0.1:64571_solr
x:routeFieldColl_shard2_replica2 s:shard2 c:routeFieldColl)
[n:127.0.0.1:64571_solr c:routeFieldColl s:shard2
x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard2_replica2] Registered new searcher
Searcher@67c27359[routeFieldColl_shard2_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244742 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785191813120
[junit4] 2> 244742 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@65d6ab6f[routeFieldColl_shard4_replica2] main]
[junit4] 2> 244749 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244750 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@695af3d4[routeFieldColl_shard1_replica2] main]
[junit4] 2> 244750 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244750 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244750 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785200201728
[junit4] 2> 244750 INFO
(searcherExecutor-980-thread-1-processing-n:127.0.0.1:64571_solr
x:routeFieldColl_shard4_replica2 s:shard4 c:routeFieldColl)
[n:127.0.0.1:64571_solr c:routeFieldColl s:shard4
x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard4_replica2] Registered new searcher
Searcher@65d6ab6f[routeFieldColl_shard4_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244751 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9996ms
[junit4] 2> 244753 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@c429cff[routeFieldColl_shard3_replica2] main]
[junit4] 2> 244757 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244757 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244757 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 244757 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 244758 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244759 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244759 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 244759 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 244762 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244764 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244764 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244765 INFO
(searcherExecutor-981-thread-1-processing-n:127.0.0.1:64570_solr
x:routeFieldColl_shard3_replica2 s:shard3 c:routeFieldColl)
[n:127.0.0.1:64570_solr c:routeFieldColl s:shard3
x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard3_replica2] Registered new searcher
Searcher@c429cff[routeFieldColl_shard3_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244765 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244765 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785215930368
[junit4] 2> 244766 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244767 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244767 INFO
(searcherExecutor-983-thread-1-processing-n:127.0.0.1:64570_solr
x:routeFieldColl_shard1_replica2 s:shard1 c:routeFieldColl)
[n:127.0.0.1:64570_solr c:routeFieldColl s:shard1
x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica2] Registered new searcher
Searcher@695af3d4[routeFieldColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244767 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785218027520
[junit4] 2> 244774 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@59937502[routeFieldColl_shard3_replica1] main]
[junit4] 2> 244774 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@ab4fd21[routeFieldColl_shard4_replica1] main]
[junit4] 2> 244776 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244777 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244777 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244777 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785228513280
[junit4] 2> 244777 INFO
(searcherExecutor-984-thread-1-processing-n:127.0.0.1:64569_solr
x:routeFieldColl_shard4_replica1 s:shard4 c:routeFieldColl)
[n:127.0.0.1:64569_solr c:routeFieldColl s:shard4
x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard4_replica1] Registered new searcher
Searcher@ab4fd21[routeFieldColl_shard4_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244779 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 244779 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 244780 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 244780 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566204785231659008
[junit4] 2> 244780 INFO
(searcherExecutor-987-thread-1-processing-n:127.0.0.1:64568_solr
x:routeFieldColl_shard3_replica1 s:shard3 c:routeFieldColl)
[n:127.0.0.1:64568_solr c:routeFieldColl s:shard3
x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard3_replica1] Registered new searcher
Searcher@59937502[routeFieldColl_shard3_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 244788 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard2: total=2 found=1 timeoutin=9991ms
[junit4] 2> 244789 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard4: total=2 found=1 timeoutin=9995ms
[junit4] 2> 244796 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 244796 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 244796 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:64568/solr/routeFieldColl_shard3_replica1/
[junit4] 2> 244797 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard3_replica1 url=https://127.0.0.1:64568/solr
START replicas=[https://127.0.0.1:64570/solr/routeFieldColl_shard3_replica2/]
nUpdates=100
[junit4] 2> 244797 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard3_replica1 url=https://127.0.0.1:64568/solr
DONE. We have no versions. sync failed.
[junit4] 2> 244840 INFO (qtp1802356265-1625) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 r:core_node4 x:routeFieldColl_shard3_replica2]
o.a.s.c.S.Request [routeFieldColl_shard3_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 244841 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 244841 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 244841 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 244850 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:64568/solr/routeFieldColl_shard3_replica1/ shard3
[junit4] 2> 244961 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 244962 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 244962 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 244963 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245017 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 245022 INFO (qtp1348432298-1610) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2}
status=0 QTime=1763
[junit4] 2> 245129 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245129 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245129 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245129 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245259 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 245259 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 245259 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:64568/solr/routeFieldColl_shard1_replica1/
[junit4] 2> 245259 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard1_replica1 url=https://127.0.0.1:64568/solr
START replicas=[https://127.0.0.1:64570/solr/routeFieldColl_shard1_replica2/]
nUpdates=100
[junit4] 2> 245259 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard1_replica1 url=https://127.0.0.1:64568/solr
DONE. We have no versions. sync failed.
[junit4] 2> 245269 INFO (qtp1802356265-1626) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 r:core_node8 x:routeFieldColl_shard1_replica2]
o.a.s.c.S.Request [routeFieldColl_shard1_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 245270 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 245270 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 245270 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 245278 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:64568/solr/routeFieldColl_shard1_replica1/ shard1
[junit4] 2> 245297 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 245297 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 245297 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:64569/solr/routeFieldColl_shard2_replica1/
[junit4] 2> 245297 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard2_replica1 url=https://127.0.0.1:64569/solr
START replicas=[https://127.0.0.1:64571/solr/routeFieldColl_shard2_replica2/]
nUpdates=100
[junit4] 2> 245297 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard2_replica1 url=https://127.0.0.1:64569/solr
DONE. We have no versions. sync failed.
[junit4] 2> 245299 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 245299 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 245299 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:64569/solr/routeFieldColl_shard4_replica1/
[junit4] 2> 245299 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard4_replica1 url=https://127.0.0.1:64569/solr
START replicas=[https://127.0.0.1:64571/solr/routeFieldColl_shard4_replica2/]
nUpdates=100
[junit4] 2> 245300 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard4_replica1 url=https://127.0.0.1:64569/solr
DONE. We have no versions. sync failed.
[junit4] 2> 245310 INFO (qtp1249989868-1645) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 r:core_node2 x:routeFieldColl_shard4_replica2]
o.a.s.c.S.Request [routeFieldColl_shard4_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 245310 INFO (qtp1249989868-1641) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 r:core_node1 x:routeFieldColl_shard2_replica2]
o.a.s.c.S.Request [routeFieldColl_shard2_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 245311 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 245311 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 245311 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 245311 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 245311 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 245311 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 245319 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:64569/solr/routeFieldColl_shard2_replica1/ shard2
[junit4] 2> 245319 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:64569/solr/routeFieldColl_shard4_replica1/ shard4
[junit4] 2> 245431 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245431 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245431 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245431 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245438 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 245441 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2}
status=0 QTime=2186
[junit4] 2> 245479 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 245480 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 245483 INFO (qtp947111904-1635) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2}
status=0 QTime=2223
[junit4] 2> 245484 INFO (qtp947111904-1633) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica1&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2}
status=0 QTime=2235
[junit4] 2> 245600 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245600 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245600 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245600 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245800 INFO (qtp1802356265-1629) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard1_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard1&wt=javabin&version=2}
status=0 QTime=2543
[junit4] 2> 245840 INFO (qtp1249989868-1640) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard4_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard4&wt=javabin&version=2}
status=0 QTime=2604
[junit4] 2> 245842 INFO (qtp1802356265-1628) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard3_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard3&wt=javabin&version=2}
status=0 QTime=2593
[junit4] 2> 245864 INFO (qtp1249989868-1617) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=routeFieldColl_shard2_replica2&action=CREATE&numShards=4&collection=routeFieldColl&shard=shard2&wt=javabin&version=2}
status=0 QTime=2631
[junit4] 2> 245870 INFO (qtp1249989868-1642) [n:127.0.0.1:64571_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> 245975 INFO
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245975 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245975 INFO
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 245975 INFO
(zkCallback-250-thread-1-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/routeFieldColl/state.json] for collection [routeFieldColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 246878 INFO (qtp1249989868-1642) [n:127.0.0.1:64571_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=3&router.field=shard_s&name=routeFieldColl&action=CREATE&numShards=4&wt=javabin&version=2}
status=0 QTime=3833
[junit4] 2> 246970 INFO (qtp1802356265-1625) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard1 r:core_node8 x:routeFieldColl_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard1_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:64568/solr/routeFieldColl_shard1_replica1/&wt=javabin&version=2}{add=[8
(1566204787471417344)]} 0 4
[junit4] 2> 246973 INFO (qtp1802356265-1619) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 r:core_node4 x:routeFieldColl_shard3_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard3_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:64568/solr/routeFieldColl_shard3_replica1/&wt=javabin&version=2}{add=[6
(1566204787471417344), 7 (1566204787503923200)]} 0 8
[junit4] 2> 246975 INFO (qtp1348432298-1614) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard1 r:core_node6 x:routeFieldColl_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard1_replica1]
webapp=/solr path=/update
params={_stateVer_=routeFieldColl:6&wt=javabin&version=2}{add=[8
(1566204787471417344)]} 0 79
[junit4] 2> 246975 INFO (qtp1348432298-1613) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 r:core_node7 x:routeFieldColl_shard3_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard3_replica1]
webapp=/solr path=/update
params={_stateVer_=routeFieldColl:6&wt=javabin&version=2}{add=[6
(1566204787471417344), 7 (1566204787503923200)]} 0 79
[junit4] 2> 247000 INFO (qtp1802356265-1626) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 r:core_node4 x:routeFieldColl_shard3_replica2]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247000 INFO (qtp1802356265-1626) [n:127.0.0.1:64570_solr
c:routeFieldColl s:shard3 r:core_node4 x:routeFieldColl_shard3_replica2]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@44f37a94
[junit4] 2> 247001 INFO (qtp947111904-1615) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 r:core_node5 x:routeFieldColl_shard4_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247002 INFO (qtp947111904-1615) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 r:core_node5 x:routeFieldColl_shard4_replica1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 247003 INFO (qtp947111904-1615) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 r:core_node5 x:routeFieldColl_shard4_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 247008 INFO (qtp1249989868-1644) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 r:core_node2 x:routeFieldColl_shard4_replica2]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247008 INFO (qtp1249989868-1644) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 r:core_node2 x:routeFieldColl_shard4_replica2]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 247011 INFO (qtp1249989868-1644) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 r:core_node2 x:routeFieldColl_shard4_replica2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 247011 INFO (qtp947111904-1615) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard4 r:core_node5 x:routeFieldColl_shard4_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard4_replica1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:64568/solr/routeFieldColl_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 10
[junit4] 2> 247012 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 r:core_node7 x:routeFieldColl_shard3_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247012 INFO (qtp1348432298-1616) [n:127.0.0.1:64568_solr
c:routeFieldColl s:shard3 r:core_node7 x:routeFieldColl_shard3_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@759a2a64
[junit4] 2> 247013 INFO (qtp1249989868-1644) [n:127.0.0.1:64571_solr
c:routeFieldColl s:shard4 r:core_node2 x:routeFieldColl_shard4_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard4_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:64568/solr/routeFieldColl_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 4
[junit4] 2> 247014 INFO (qtp947111904-1631) [n:127.0.0.1:64569_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldCol
[...truncated too long message...]
66
[junit4] 2> 268732 INFO
(OverseerThreadFactory-971-thread-5-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.CreateCollectionCmd Cleaned up artifacts
for failed create collection for [withShardField]
[junit4] 2> 268738 INFO (qtp1249989868-1854) [n:127.0.0.1:64571_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> 270440 INFO
(OverseerCollectionConfigSetProcessor-97887798882861065-127.0.0.1:64568_solr-n_0000000000)
[n:127.0.0.1:64568_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000016 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 298874 ERROR (qtp1249989868-1854) [n:127.0.0.1:64571_solr ]
o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas to
become ACTIVE with timeout=30
[junit4] 2> 298874 INFO (qtp1249989868-1854) [n:127.0.0.1:64571_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={shards=a,b,c,d&replicationFactor=5&collection.configName=conf&maxShardsPerNode=6&router.field=shard_s&name=withShardField&router.name=implicit&action=CREATE&wt=javabin&version=2}
status=0 QTime=34460
[junit4] 2> 298875 INFO
(TEST-CustomCollectionTest.testRouteFieldForImplicitRouter-seed#[1665D046525E1607])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testRouteFieldForImplicitRouter
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CustomCollectionTest -Dtests.method=testRouteFieldForImplicitRouter
-Dtests.seed=1665D046525E1607 -Dtests.slow=true -Dtests.locale=th
-Dtests.timezone=AST -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 35.4s J0 |
CustomCollectionTest.testRouteFieldForImplicitRouter <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Collection
not found: withShardField
[junit4] > at
__randomizedtesting.SeedInfo.seed([1665D046525E1607:433538D4FEA7D9F7]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.getCollectionNames(CloudSolrClient.java:1401)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1094)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1073)
[junit4] > at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
[junit4] > at
org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233)
[junit4] > at
org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter(CustomCollectionTest.java:141)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 298904 INFO (jetty-closer-229-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@7b7487b1{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 298907 INFO (jetty-closer-229-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@70c857ee{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 298909 INFO (jetty-closer-229-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1420088e{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 298910 INFO (jetty-closer-229-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1755841127
[junit4] 2> 298910 INFO (jetty-closer-229-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2084876449
[junit4] 2> 298911 INFO (jetty-closer-229-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1303745631
[junit4] 2> 298912 INFO (jetty-closer-229-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@6ede2482{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 298913 INFO (jetty-closer-229-thread-4) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=159624496
[junit4] 2> 298930 WARN
(zkCallback-248-thread-1-processing-n:127.0.0.1:64570_solr)
[n:127.0.0.1:64570_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 298931 WARN
(zkCallback-250-thread-4-processing-n:127.0.0.1:64571_solr)
[n:127.0.0.1:64571_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 298934 INFO (jetty-closer-229-thread-4) [ ]
o.a.s.c.Overseer Overseer
(id=97887798882861065-127.0.0.1:64568_solr-n_0000000000) closing
[junit4] 2> 298934 INFO
(OverseerStateUpdate-97887798882861065-127.0.0.1:64568_solr-n_0000000000)
[n:127.0.0.1:64568_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:64568_solr
[junit4] 2> 298934 INFO (jetty-closer-229-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 298935 INFO (jetty-closer-229-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 298935 INFO
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (1)
[junit4] 2> 298936 INFO (jetty-closer-229-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7613b8a8{/solr,null,UNAVAILABLE}
[junit4] 2> 298936 INFO (jetty-closer-229-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7c6da409{/solr,null,UNAVAILABLE}
[junit4] 2> 298945 WARN
(zkCallback-247-thread-1-processing-n:127.0.0.1:64568_solr)
[n:127.0.0.1:64568_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 298945 INFO (jetty-closer-229-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 298946 INFO (jetty-closer-229-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3ade8ff7{/solr,null,UNAVAILABLE}
[junit4] 2> 300435 WARN
(zkCallback-249-thread-1-processing-n:127.0.0.1:64569_solr)
[n:127.0.0.1:64569_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 300435 INFO (jetty-closer-229-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 300436 INFO (jetty-closer-229-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1622e4d8{/solr,null,UNAVAILABLE}
[junit4] 2> 300438 ERROR
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-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> 300438 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:64566 64566
[junit4] 2> 300593 INFO (Thread-514) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:64566 64566
[junit4] 2> 309624 WARN (Thread-514) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/configs/conf
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 5 /solr/collections/implicitcoll/state.json
[junit4] 2> 4
/solr/collections/testCreateShardRepFactor/state.json
[junit4] 2> 4 /solr/collections/routeFieldColl/state.json
[junit4] 2> 4 /solr/collections/withShardField/state.json
[junit4] 2> 2
/solr/collections/implicitcoll/leader_elect/x/election/97887798882861067-core_node20-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 32 /solr/collections
[junit4] 2> 9 /solr/live_nodes
[junit4] 2>
[junit4] 2> 309624 INFO
(SUITE-CustomCollectionTest-seed#[1665D046525E1607]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_1665D046525E1607-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{shard_s=PostingsFormat(name=LuceneVarGapFixedInterval),
_version_=PostingsFormat(name=LuceneFixedGap), id=Lucene50(blocksize=128),
_route_=PostingsFormat(name=Direct)}, docValues:{}, maxPointsInLeafNode=1066,
maxMBSortInHeap=5.943446629911637,
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=th, timezone=AST
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121
(64-bit)/cpus=3,threads=1,free=290453952,total=449839104
[junit4] 2> NOTE: All tests run in this JVM: [ZkNodePropsTest,
QueryEqualityTest, SolrSlf4jReporterTest, ClusterStateUpdateTest, TestUpdate,
CheckHdfsIndexTest, AlternateDirectoryTest, TestSolr4Spatial2,
HdfsSyncSliceTest, TestCoreAdminApis, TestHdfsBackupRestoreCore,
TestJsonFacetRefinement, SpatialFilterTest, TestJavabinTupleStreamParser,
OutputWriterTest, TestHighFrequencyDictionaryFactory, FileUtilsTest,
PeerSyncReplicationTest, TestOverriddenPrefixQueryForCustomFieldType,
TestPointFields, TestJettySolrRunner, SpatialHeatmapFacetsTest,
DeleteReplicaTest, TestFastOutputStream, DisMaxRequestHandlerTest,
RankQueryTest, ActionThrottleTest, TestCorePropertiesReload,
TestSimpleQParserPlugin, HttpSolrCallGetCoreTest, TestPostingsSolrHighlighter,
TestSerializedLuceneMatchVersion, PingRequestHandlerTest, CustomCollectionTest]
[junit4] Completed [88/708 (1!)] on J0 in 67.85s, 4 tests, 1 error <<<
FAILURES!
[...truncated 45468 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
