Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-MacOSX/906/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.CustomCollectionTest.testCustomCollectionsAPI
Error Message:
Could not find collection : implicitcoll
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : implicitcoll
at
__randomizedtesting.SeedInfo.seed([77DD562FBF85F852:1D3CD844821F4E2A]:0)
at
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:194)
at
org.apache.solr.cloud.SolrCloudTestCase.getCollectionState(SolrCloudTestCase.java:245)
at
org.apache.solr.cloud.CustomCollectionTest.testCustomCollectionsAPI(CustomCollectionTest.java:68)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11810 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_77DD562FBF85F852-001/init-core-data-001
[junit4] 2> 955479 WARN
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 955479 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 955482 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
w/ MAC_OS_X supressed clientAuth
[junit4] 2> 955482 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-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_77DD562FBF85F852-001/tempDir-001
[junit4] 2> 955482 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 955483 INFO (Thread-2041) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 955483 INFO (Thread-2041) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 955485 ERROR (Thread-2041) [ ] 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> 955583 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:65320
[junit4] 2> 955601 INFO (jetty-launcher-1670-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 955602 INFO (jetty-launcher-1670-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 955603 INFO (jetty-launcher-1670-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 955604 INFO (jetty-launcher-1670-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6002ff92{/solr,null,AVAILABLE}
[junit4] 2> 955605 INFO (jetty-launcher-1670-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 955606 INFO (jetty-launcher-1670-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@47770245{/solr,null,AVAILABLE}
[junit4] 2> 955607 INFO (jetty-launcher-1670-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@79f2cef7{/solr,null,AVAILABLE}
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@58bfb0e{HTTP/1.1,[http/1.1]}{127.0.0.1:65324}
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@736afcf5{HTTP/1.1,[http/1.1]}{127.0.0.1:65325}
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@427f070b{HTTP/1.1,[http/1.1]}{127.0.0.1:65326}
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-4) [ ]
o.e.j.s.Server Started @960316ms
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-1) [ ]
o.e.j.s.Server Started @960316ms
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65325}
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65326}
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@70416661{/solr,null,AVAILABLE}
[junit4] 2> 955611 ERROR (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1947b3a8{HTTP/1.1,[http/1.1]}{127.0.0.1:65327}
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-3) [ ]
o.e.j.s.Server Started @960317ms
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65327}
[junit4] 2> 955610 INFO (jetty-launcher-1670-thread-2) [ ]
o.e.j.s.Server Started @960316ms
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=65324}
[junit4] 2> 955612 ERROR (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 955612 ERROR (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 955611 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.7.0
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.7.0
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-03T18:26:46.363Z
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-03T18:26:46.363Z
[junit4] 2> 955611 ERROR (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 955612 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.7.0
[junit4] 2> 955613 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 955613 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 955613 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-03T18:26:46.364Z
[junit4] 2> 955613 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.7.0
[junit4] 2> 955614 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 955614 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 955614 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-03T18:26:46.365Z
[junit4] 2> 955618 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 955618 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 955619 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 955634 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 955635 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 955635 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 955635 INFO (jetty-launcher-1670-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65320/solr
[junit4] 2> 955636 INFO (jetty-launcher-1670-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65320/solr
[junit4] 2> 955637 INFO (jetty-launcher-1670-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65320/solr
[junit4] 2> 955640 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 955666 INFO (jetty-launcher-1670-thread-3)
[n:127.0.0.1:65327_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 955667 INFO (jetty-launcher-1670-thread-4)
[n:127.0.0.1:65325_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 955667 INFO (jetty-launcher-1670-thread-1)
[n:127.0.0.1:65326_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 955667 INFO (jetty-launcher-1670-thread-3)
[n:127.0.0.1:65327_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:65327_solr
[junit4] 2> 955668 INFO (jetty-launcher-1670-thread-1)
[n:127.0.0.1:65326_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65326_solr
[junit4] 2> 955668 INFO (jetty-launcher-1670-thread-4)
[n:127.0.0.1:65325_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65325_solr
[junit4] 2> 955669 INFO (jetty-launcher-1670-thread-3)
[n:127.0.0.1:65327_solr ] o.a.s.c.Overseer Overseer
(id=98075568127082504-127.0.0.1:65327_solr-n_0000000000) starting
[junit4] 2> 955670 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 955671 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 955671 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 955682 INFO (jetty-launcher-1670-thread-3)
[n:127.0.0.1:65327_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65327_solr
[junit4] 2> 955685 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 955685 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 955685 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 955697 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 955697 INFO (jetty-launcher-1670-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65320/solr
[junit4] 2> 955710 INFO (jetty-launcher-1670-thread-2)
[n:127.0.0.1:65324_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 955713 INFO (jetty-launcher-1670-thread-2)
[n:127.0.0.1:65324_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 955716 INFO (jetty-launcher-1670-thread-2)
[n:127.0.0.1:65324_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65324_solr
[junit4] 2> 955718 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 955718 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 955719 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 955730 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 955785 INFO (jetty-launcher-1670-thread-1)
[n:127.0.0.1:65326_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_77DD562FBF85F852-001/tempDir-001/node1/.
[junit4] 2> 955787 INFO (jetty-launcher-1670-thread-3)
[n:127.0.0.1:65327_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_77DD562FBF85F852-001/tempDir-001/node3/.
[junit4] 2> 955802 INFO (jetty-launcher-1670-thread-4)
[n:127.0.0.1:65325_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_77DD562FBF85F852-001/tempDir-001/node4/.
[junit4] 2> 955835 INFO (jetty-launcher-1670-thread-2)
[n:127.0.0.1:65324_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_77DD562FBF85F852-001/tempDir-001/node2/.
[junit4] 2> 955853 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 955854 INFO
(SUITE-CustomCollectionTest-seed#[77DD562FBF85F852]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:65320/solr ready
[junit4] 2> 955888 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[77DD562FBF85F852])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testRouteFieldForHashRouter
[junit4] 2> 955889 INFO
(TEST-CustomCollectionTest.testRouteFieldForHashRouter-seed#[77DD562FBF85F852])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 955900 INFO (qtp258156407-9321) [n:127.0.0.1:65324_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> 955903 INFO
(OverseerThreadFactory-4572-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_solr ] o.a.s.c.CreateCollectionCmd Create collection
routeFieldColl
[junit4] 2> 956023 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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> 956024 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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> 956025 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 956025 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 956025 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 956025 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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> 956025 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 956026 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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> 956026 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 956026 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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> 956026 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 956026 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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> 956150 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_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> 956150 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_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> 956150 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_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> 956150 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_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> 957079 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957079 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957082 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957084 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957097 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957097 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957099 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957101 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 957114 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica2] Schema name=cloud-dynamic
[junit4] 2> 957114 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica2] Schema name=cloud-dynamic
[junit4] 2> 957116 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica1] Schema name=cloud-dynamic
[junit4] 2> 957133 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica1] Schema name=cloud-dynamic
[junit4] 2> 957134 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard3_replica1] Schema name=cloud-dynamic
[junit4] 2> 957136 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard2_replica2] Schema name=cloud-dynamic
[junit4] 2> 957161 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.IndexSchema [routeFieldColl_shard1_replica1] Schema name=cloud-dynamic
[junit4] 2> 957187 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.IndexSchema [routeFieldColl_shard4_replica2] Schema name=cloud-dynamic
[junit4] 2> 957202 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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> 957203 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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> 957203 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957203 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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_77DD562FBF85F852-001/tempDir-001/node2/routeFieldColl_shard2_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node2/./routeFieldColl_shard2_replica1/data/]
[junit4] 2> 957206 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957206 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957206 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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> 957206 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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> 957206 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957206 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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_77DD562FBF85F852-001/tempDir-001/node3/routeFieldColl_shard3_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node3/./routeFieldColl_shard3_replica1/data/]
[junit4] 2> 957206 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957206 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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_77DD562FBF85F852-001/tempDir-001/node4/routeFieldColl_shard2_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node4/./routeFieldColl_shard2_replica2/data/]
[junit4] 2> 957207 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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> 957207 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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> 957208 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957208 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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_77DD562FBF85F852-001/tempDir-001/node1/routeFieldColl_shard1_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node1/./routeFieldColl_shard1_replica2/data/]
[junit4] 2> 957208 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957208 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957208 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957208 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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_77DD562FBF85F852-001/tempDir-001/node3/routeFieldColl_shard1_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node3/./routeFieldColl_shard1_replica1/data/]
[junit4] 2> 957210 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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> 957210 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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> 957211 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957211 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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_77DD562FBF85F852-001/tempDir-001/node2/routeFieldColl_shard4_replica1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node2/./routeFieldColl_shard4_replica1/data/]
[junit4] 2> 957212 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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> 957212 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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> 957212 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957212 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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_77DD562FBF85F852-001/tempDir-001/node1/routeFieldColl_shard3_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node1/./routeFieldColl_shard3_replica2/data/]
[junit4] 2> 957212 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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> 957213 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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> 957213 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 957213 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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_77DD562FBF85F852-001/tempDir-001/node4/routeFieldColl_shard4_replica2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_77DD562FBF85F852-001/tempDir-001/node4/./routeFieldColl_shard4_replica2/data/]
[junit4] 2> 957283 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957283 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957284 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957284 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957285 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957285 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957286 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957286 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957290 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957290 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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> 957292 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957292 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957294 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7edd5de2[routeFieldColl_shard3_replica1] main]
[junit4] 2> 957294 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@719c2bbe[routeFieldColl_shard1_replica1] main]
[junit4] 2> 957295 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957296 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957296 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957296 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957296 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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
1569209091932291072
[junit4] 2> 957298 INFO
(searcherExecutor-4586-thread-1-processing-n:127.0.0.1:65327_solr
x:routeFieldColl_shard3_replica1 s:shard3 c:routeFieldColl)
[n:127.0.0.1:65327_solr c:routeFieldColl s:shard3
x:routeFieldColl_shard3_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard3_replica1] Registered new searcher
Searcher@7edd5de2[routeFieldColl_shard3_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957298 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957298 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957298 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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
1569209091934388224
[junit4] 2> 957298 INFO
(searcherExecutor-4589-thread-1-processing-n:127.0.0.1:65327_solr
x:routeFieldColl_shard1_replica1 s:shard1 c:routeFieldColl)
[n:127.0.0.1:65327_solr c:routeFieldColl s:shard1
x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica1] Registered new searcher
Searcher@719c2bbe[routeFieldColl_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957304 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@160fc46c[routeFieldColl_shard2_replica2] main]
[junit4] 2> 957304 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard3: total=2 found=1 timeoutin=9999ms
[junit4] 2> 957306 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957306 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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> 957306 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957306 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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
1569209091942776832
[junit4] 2> 957306 INFO
(searcherExecutor-4587-thread-1-processing-n:127.0.0.1:65325_solr
x:routeFieldColl_shard2_replica2 s:shard2 c:routeFieldColl)
[n:127.0.0.1:65325_solr c:routeFieldColl s:shard2
x:routeFieldColl_shard2_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard2_replica2] Registered new searcher
Searcher@160fc46c[routeFieldColl_shard2_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957314 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 957317 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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=9999ms
[junit4] 2> 957321 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957322 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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> 957324 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957324 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957326 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@692f4ee[routeFieldColl_shard4_replica2] main]
[junit4] 2> 957328 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957328 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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> 957328 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957328 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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
1569209091965845504
[junit4] 2> 957328 INFO
(searcherExecutor-4592-thread-1-processing-n:127.0.0.1:65325_solr
x:routeFieldColl_shard4_replica2 s:shard4 c:routeFieldColl)
[n:127.0.0.1:65325_solr c:routeFieldColl s:shard4
x:routeFieldColl_shard4_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard4_replica2] Registered new searcher
Searcher@692f4ee[routeFieldColl_shard4_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957335 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard4: total=2 found=1 timeoutin=9999ms
[junit4] 2> 957355 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957355 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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> 957356 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957356 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957358 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@599783fd[routeFieldColl_shard3_replica2] main]
[junit4] 2> 957358 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957358 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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> 957360 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957360 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957360 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957360 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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> 957360 INFO (qtp863498562-9312) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957361 INFO
(searcherExecutor-4591-thread-1-processing-n:127.0.0.1:65326_solr
x:routeFieldColl_shard3_replica2 s:shard3 c:routeFieldColl)
[n:127.0.0.1:65326_solr c:routeFieldColl s:shard3
x:routeFieldColl_shard3_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard3_replica2] Registered new searcher
Searcher@599783fd[routeFieldColl_shard3_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957361 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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
1569209092000448512
[junit4] 2> 957361 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957361 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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> 957362 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957362 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957362 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@5c4b4173[routeFieldColl_shard1_replica2] main]
[junit4] 2> 957363 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@349cdb7c[routeFieldColl_shard4_replica1] main]
[junit4] 2> 957364 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957364 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957364 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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> 957364 INFO (qtp863498562-9313) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957365 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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> 957365 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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
1569209092004642816
[junit4] 2> 957365 INFO (qtp258156407-9324) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957365 INFO
(searcherExecutor-4588-thread-1-processing-n:127.0.0.1:65326_solr
x:routeFieldColl_shard1_replica2 s:shard1 c:routeFieldColl)
[n:127.0.0.1:65326_solr c:routeFieldColl s:shard1
x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica2] Registered new searcher
Searcher@5c4b4173[routeFieldColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957365 INFO
(searcherExecutor-4590-thread-1-processing-n:127.0.0.1:65324_solr
x:routeFieldColl_shard4_replica1 s:shard4 c:routeFieldColl)
[n:127.0.0.1:65324_solr c:routeFieldColl s:shard4
x:routeFieldColl_shard4_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard4_replica1] Registered new searcher
Searcher@349cdb7c[routeFieldColl_shard4_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957365 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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
1569209092004642816
[junit4] 2> 957374 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 957374 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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> 957377 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 957377 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 957377 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@496ab2ce[routeFieldColl_shard2_replica1] main]
[junit4] 2> 957379 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 957379 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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> 957379 INFO (qtp258156407-9325) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 957380 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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
1569209092020371456
[junit4] 2> 957380 INFO
(searcherExecutor-4585-thread-1-processing-n:127.0.0.1:65324_solr
x:routeFieldColl_shard2_replica1 s:shard2 c:routeFieldColl)
[n:127.0.0.1:65324_solr c:routeFieldColl s:shard2
x:routeFieldColl_shard2_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard2_replica1] Registered new searcher
Searcher@496ab2ce[routeFieldColl_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 957449 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_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> 957449 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_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> 957449 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_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> 957449 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_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> 957815 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 957815 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 957816 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957816 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:65327/solr/routeFieldColl_shard3_replica1/
[junit4] 2> 957816 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 957816 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:65325/solr/routeFieldColl_shard2_replica2/
[junit4] 2> 957816 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard3_replica1 url=http://127.0.0.1:65327/solr
START replicas=[http://127.0.0.1:65326/solr/routeFieldColl_shard3_replica2/]
nUpdates=100
[junit4] 2> 957816 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard2_replica2 url=http://127.0.0.1:65325/solr
START replicas=[http://127.0.0.1:65324/solr/routeFieldColl_shard2_replica1/]
nUpdates=100
[junit4] 2> 957817 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard3_replica1 url=http://127.0.0.1:65327/solr
DONE. We have no versions. sync failed.
[junit4] 2> 957818 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard2_replica2 url=http://127.0.0.1:65325/solr
DONE. We have no versions. sync failed.
[junit4] 2> 957821 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 r:core_node5 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> 957822 INFO (qtp258156407-9319) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldColl_shard2_replica1]
o.a.s.c.S.Request [routeFieldColl_shard2_replica1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 957822 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957822 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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> 957823 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 957823 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
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> 957823 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 957823 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 957826 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 957826 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957826 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/
[junit4] 2> 957827 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard1_replica1 url=http://127.0.0.1:65327/solr
START replicas=[http://127.0.0.1:65326/solr/routeFieldColl_shard1_replica2/]
nUpdates=100
[junit4] 2> 957827 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard1_replica1 url=http://127.0.0.1:65327/solr
DONE. We have no versions. sync failed.
[junit4] 2> 957831 INFO (qtp863498562-9315) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 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=1
[junit4] 2> 957832 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957832 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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> 957832 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 957837 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:65325/solr/routeFieldColl_shard2_replica2/ shard2
[junit4] 2> 957837 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:65327/solr/routeFieldColl_shard3_replica1/ shard3
[junit4] 2> 957837 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 957837 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 957837 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:65325/solr/routeFieldColl_shard4_replica2/
[junit4] 2> 957838 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard4_replica2 url=http://127.0.0.1:65325/solr
START replicas=[http://127.0.0.1:65324/solr/routeFieldColl_shard4_replica1/]
nUpdates=100
[junit4] 2> 957838 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2] o.a.s.u.PeerSync
PeerSync: core=routeFieldColl_shard4_replica2 url=http://127.0.0.1:65325/solr
DONE. We have no versions. sync failed.
[junit4] 2> 957842 INFO (qtp258156407-9323) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 r:core_node6 x:routeFieldColl_shard4_replica1]
o.a.s.c.S.Request [routeFieldColl_shard4_replica1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 957842 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 957842 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
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> 957842 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 957845 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/ shard1
[junit4] 2> 957852 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:65325/solr/routeFieldColl_shard4_replica2/ shard4
[junit4] 2> 957966 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_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> 957966 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_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> 957966 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_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> 957966 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_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> 958025 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 x:routeFieldColl_shard3_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 958025 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 x:routeFieldColl_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 958025 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 x:routeFieldColl_shard4_replica2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 958025 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 x:routeFieldColl_shard2_replica2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 958028 INFO (qtp1352641102-9342) [n:127.0.0.1:65325_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=2002
[junit4] 2> 958028 INFO (qtp1352641102-9344) [n:127.0.0.1:65325_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=2002
[junit4] 2> 958030 INFO (qtp1550831801-9331) [n:127.0.0.1:65327_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=2005
[junit4] 2> 958031 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_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=2006
[junit4] 2> 958149 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_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> 958149 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_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> 958149 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_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> 958150 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_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> 958377 INFO (qtp258156407-9324) [n:127.0.0.1:65324_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=2354
[junit4] 2> 958378 INFO (qtp863498562-9312) [n:127.0.0.1:65326_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=2352
[junit4] 2> 958380 INFO (qtp863498562-9313) [n:127.0.0.1:65326_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=2353
[junit4] 2> 958393 INFO (qtp258156407-9325) [n:127.0.0.1:65324_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=2370
[junit4] 2> 958400 INFO (qtp258156407-9321) [n:127.0.0.1:65324_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> 958500 INFO
(zkCallback-1688-thread-1-processing-n:127.0.0.1:65325_solr)
[n:127.0.0.1:65325_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> 958500 INFO
(zkCallback-1695-thread-1-processing-n:127.0.0.1:65324_solr)
[n:127.0.0.1:65324_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> 958500 INFO
(zkCallback-1687-thread-1-processing-n:127.0.0.1:65326_solr)
[n:127.0.0.1:65326_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> 958501 INFO
(zkCallback-1686-thread-1-processing-n:127.0.0.1:65327_solr)
[n:127.0.0.1:65327_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> 959411 INFO (qtp258156407-9321) [n:127.0.0.1:65324_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=3510
[junit4] 2> 959445 INFO (qtp863498562-9317) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard1_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&wt=javabin&version=2}{add=[8
(1569209094180438016)]} 0 1
[junit4] 2> 959445 INFO (qtp863498562-9310) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 r:core_node5 x:routeFieldColl_shard3_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard3_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:65327/solr/routeFieldColl_shard3_replica1/&wt=javabin&version=2}{add=[6
(1569209094179389440), 7 (1569209094182535168)]} 0 1
[junit4] 2> 959445 INFO (qtp1550831801-9333) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 r:core_node2 x:routeFieldColl_shard3_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard3_replica1]
webapp=/solr path=/update
params={_stateVer_=routeFieldColl:5&wt=javabin&version=2}{add=[6
(1569209094179389440), 7 (1569209094182535168)]} 0 32
[junit4] 2> 959446 INFO (qtp1550831801-9334) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 r:core_node4 x:routeFieldColl_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard1_replica1]
webapp=/solr path=/update
params={_stateVer_=routeFieldColl:5&wt=javabin&version=2}{add=[8
(1569209094180438016)]} 0 32
[junit4] 2> 959451 INFO (qtp1550831801-9329) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 r:core_node4 x:routeFieldColl_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 959451 INFO (qtp258156407-9322) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldColl_shard2_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 959451 INFO (qtp258156407-9322) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldColl_shard2_replica1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 959451 INFO (qtp1550831801-9329) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 r:core_node4 x:routeFieldColl_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@129d7a00
[junit4] 2> 959451 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 959451 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@10cb8f4f
[junit4] 2> 959452 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 r:core_node2 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> 959452 INFO (qtp1352641102-9345) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 r:core_node8 x:routeFieldColl_shard2_replica2]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 959452 INFO (qtp1550831801-9332) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard3 r:core_node2 x:routeFieldColl_shard3_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7259339d
[junit4] 2> 959454 INFO (qtp863498562-9315) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 r:core_node5 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> 959454 INFO (qtp863498562-9315) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard3 r:core_node5 x:routeFieldColl_shard3_replica2]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@20e30a44
[junit4] 2> 959453 INFO (qtp1352641102-9345) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 r:core_node8 x:routeFieldColl_shard2_replica2]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 959455 INFO (qtp258156407-9322) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldColl_shard2_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959455 INFO (qtp258156407-9326) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 r:core_node6 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> 959455 INFO (qtp1352641102-9346) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 r:core_node1 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> 959455 INFO (qtp258156407-9322) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard2 r:core_node3 x:routeFieldColl_shard2_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard2_replica1]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 4
[junit4] 2> 959455 INFO (qtp258156407-9326) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 r:core_node6 x:routeFieldColl_shard4_replica1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 959456 INFO (qtp1352641102-9345) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 r:core_node8 x:routeFieldColl_shard2_replica2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959457 INFO (qtp1352641102-9345) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard2 r:core_node8 x:routeFieldColl_shard2_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard2_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 4
[junit4] 2> 959456 INFO (qtp1352641102-9346) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 r:core_node1 x:routeFieldColl_shard4_replica2]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 959458 INFO (qtp258156407-9326) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 r:core_node6 x:routeFieldColl_shard4_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959459 INFO (qtp258156407-9326) [n:127.0.0.1:65324_solr
c:routeFieldColl s:shard4 r:core_node6 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=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 3
[junit4] 2> 959459 INFO (qtp1352641102-9346) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 r:core_node1 x:routeFieldColl_shard4_replica2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959459 INFO (qtp1352641102-9346) [n:127.0.0.1:65325_solr
c:routeFieldColl s:shard4 r:core_node1 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=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 3
[junit4] 2> 959465 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@19332371[routeFieldColl_shard1_replica2] main]
[junit4] 2> 959466 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959466 INFO (qtp1550831801-9329) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 r:core_node4 x:routeFieldColl_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@187ed009[routeFieldColl_shard1_replica1] main]
[junit4] 2> 959466 INFO
(searcherExecutor-4588-thread-1-processing-n:127.0.0.1:65326_solr
x:routeFieldColl_shard1_replica2 s:shard1 c:routeFieldColl r:core_node7)
[n:127.0.0.1:65326_solr c:routeFieldColl s:shard1 r:core_node7
x:routeFieldColl_shard1_replica2] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica2] Registered new searcher
Searcher@19332371[routeFieldColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C1)))}
[junit4] 2> 959466 INFO (qtp863498562-9314) [n:127.0.0.1:65326_solr
c:routeFieldColl s:shard1 r:core_node7 x:routeFieldColl_shard1_replica2]
o.a.s.u.p.LogUpdateProcessorFactory [routeFieldColl_shard1_replica2]
webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:65327/solr/routeFieldColl_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 14
[junit4] 2> 959466 INFO (qtp1550831801-9329) [n:127.0.0.1:65327_solr
c:routeFieldColl s:shard1 r:core_node4 x:routeFieldColl_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 959466 INFO
(searcherExecutor-4589-thread-1-processing-n:127.0.0.1:65327_solr
x:routeFieldColl_shard1_replica1 s:shard1 c:routeFieldColl r:core_node4)
[n:127.0.0.1:65327_solr c:routeFieldColl s:shard1 r:core_node4
x:routeFieldColl_shard1_replica1] o.a.s.c.SolrCore
[routeFieldColl_shard1_replica1] Registered new searcher
Searcher@187ed009[routeFieldColl_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C1)))}
[junit4] 2> 959467 INFO (qtp1550831801-9329) [n:127.0.
[...truncated too long message...]
core/lib/slf4j-log4j12-1.7.7.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/lib/spatial4j-0.6.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/lib/t-digest-3.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/commons-io-2.5.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/commons-math3-3.4.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/httpclient-4.4.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/httpcore-4.4.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/httpmime-4.4.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/jcl-over-slf4j-1.7.7.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/noggit-0.6.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/slf4j-api-1.7.7.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/stax2-api-3.1.4.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/woodstox-core-asl-4.4.1.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/solrj/lib/zookeeper-3.4.10.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/gmetric4j-1.0.7.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/javax.servlet-api-3.1.0.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-continuation-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-deploy-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-http-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-io-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-jmx-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-rewrite-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-security-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-server-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-servlet-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-servlets-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-util-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-webapp-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/jetty-xml-9.3.14.v20161028.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/metrics-core-3.2.2.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/metrics-ganglia-3.2.2.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/metrics-graphite-3.2.2.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/metrics-jetty9-3.2.2.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/server/lib/metrics-jvm-3.2.2.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/example/example-DIH/solr/db/lib/derby-10.9.1.0.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/example/example-DIH/solr/db/lib/hsqldb-2.4.0.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/core/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/test-framework/lib/junit-4.10.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/test-framework/lib/randomizedtesting-runner-2.5.0.jar:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/contrib/solr-analysis-extras/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/common/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/common/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/icu/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/icu/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/kuromoji/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/kuromoji/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/morfologik/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/morfologik/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/phonetic/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/phonetic/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/smartcn/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/smartcn/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/stempel/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/stempel/classes/test:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/uima/classes/java:/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/build/analysis/uima/classes/test:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-launcher.jar:/Users/jenkins/.ant/lib/ivy-2.3.0.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-antlr.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bcel.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bsf.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-log4j.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-oro.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-regexp.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-resolver.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-xalan2.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-logging.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-net.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jai.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-javamail.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jdepend.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jmf.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jsch.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit4.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-netrexx.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-swing.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-testutil.jar:/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_131.jdk/Contents/Home/lib/tools.jar:/Users/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.5.0.jar
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/contrib/solr-analysis-extras/test/temp/junit4-J0-20170603_190202_7732880124569858065403.events
@/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/contrib/solr-analysis-extras/test/temp/junit4-J0-20170603_190202_7735002493316653038030.suites
-stdin
[junit4] ERROR: JVM J0 ended with an exception: Forked process returned with
error code: 134. Very likely a JVM crash. See process stdout at:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/contrib/solr-analysis-extras/test/temp/junit4-J0-20170603_190202_7733445543687077049615.sysout
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1519)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:126)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:982)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:979)
[junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] at java.lang.Thread.run(Thread.java:748)
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/build.xml:775: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/build.xml:719: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/build.xml:59: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build.xml:287: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/common-build.xml:476: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/common-build.xml:549: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/common-build.xml:1455:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/lucene/common-build.xml:985: At
least one slave process threw an exception, first: Forked process returned with
error code: 134. Very likely a JVM crash. See process stdout at:
/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/contrib/solr-analysis-extras/test/temp/junit4-J0-20170603_190202_7733445543687077049615.sysout
Total time: 72 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
