Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4476/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([A2C5D2C034449E0E:EC6E73876BFBE4FD]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet(CollectionsAPISolrJTest.java:70)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13878 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
   [junit4]   2> 1877430 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/init-core-data-001
   [junit4]   2> 1877431 WARN  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 1877431 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1877438 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-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> 1877440 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001
   [junit4]   2> 1877440 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1877440 INFO  (Thread-3687) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1877440 INFO  (Thread-3687) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1877446 ERROR (Thread-3687) [    ] 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> 1877567 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:63524
   [junit4]   2> 1877611 INFO  (zkConnectionManagerCallback-4069-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877629 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1877631 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1877661 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1877677 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1877683 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1877683 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1877683 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1877684 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1877684 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1877684 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 1877686 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1877686 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1877686 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1877686 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1877686 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 1877687 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1877687 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5cde7dd6{/solr,null,AVAILABLE}
   [junit4]   2> 1877687 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6c3475aa{/solr,null,AVAILABLE}
   [junit4]   2> 1877689 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7c208827{/solr,null,AVAILABLE}
   [junit4]   2> 1877691 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@451582a5{HTTP/1.1,[http/1.1]}{127.0.0.1:63527}
   [junit4]   2> 1877692 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2eff2d7b{/solr,null,AVAILABLE}
   [junit4]   2> 1877693 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@4d89c701{HTTP/1.1,[http/1.1]}{127.0.0.1:63530}
   [junit4]   2> 1877693 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.e.j.s.Server Started @1882081ms
   [junit4]   2> 1877693 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63530}
   [junit4]   2> 1877693 ERROR (jetty-launcher-4066-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1877694 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1877694 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1877694 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1877700 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.e.j.s.Server Started @1882079ms
   [junit4]   2> 1877708 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63527}
   [junit4]   2> 1877708 ERROR (jetty-launcher-4066-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1877708 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-05T20:42:05.292Z
   [junit4]   2> 1877707 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@11e7db77{HTTP/1.1,[http/1.1]}{127.0.0.1:63529}
   [junit4]   2> 1877709 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.e.j.s.Server Started @1882097ms
   [junit4]   2> 1877710 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63529}
   [junit4]   2> 1877710 ERROR (jetty-launcher-4066-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1877710 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1877710 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1877710 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1877710 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-05T20:42:05.308Z
   [junit4]   2> 1877707 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@420e5871{HTTP/1.1,[http/1.1]}{127.0.0.1:63528}
   [junit4]   2> 1877713 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.e.j.s.Server Started @1882100ms
   [junit4]   2> 1877713 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=63528}
   [junit4]   2> 1877713 ERROR (jetty-launcher-4066-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1877714 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1877714 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1877714 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1877714 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-05T20:42:05.312Z
   [junit4]   2> 1877715 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1877715 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1877715 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1877715 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-05T20:42:05.313Z
   [junit4]   2> 1877725 INFO  (zkConnectionManagerCallback-4071-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877726 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1877728 INFO  (zkConnectionManagerCallback-4073-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877729 INFO  (zkConnectionManagerCallback-4075-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877731 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1877736 INFO  (zkConnectionManagerCallback-4077-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877737 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1877759 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1877946 INFO  (jetty-launcher-4066-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63524/solr
   [junit4]   2> 1877952 INFO  (zkConnectionManagerCallback-4081-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877956 INFO  (jetty-launcher-4066-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63524/solr
   [junit4]   2> 1877966 INFO  
(zkConnectionManagerCallback-4087-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877967 INFO  (zkConnectionManagerCallback-4085-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1877997 INFO  
(zkConnectionManagerCallback-4089-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1878038 INFO  (jetty-launcher-4066-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63524/solr
   [junit4]   2> 1878057 INFO  (zkConnectionManagerCallback-4095-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1878151 INFO  
(zkConnectionManagerCallback-4097-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1878158 INFO  (jetty-launcher-4066-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63524/solr
   [junit4]   2> 1878169 INFO  (zkConnectionManagerCallback-4101-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1878190 INFO  
(zkConnectionManagerCallback-4104-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1880046 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1880048 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:63527_solr
   [junit4]   2> 1880051 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.Overseer Overseer 
(id=72085126833963020-127.0.0.1:63527_solr-n_0000000000) starting
   [junit4]   2> 1880056 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1880082 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1880083 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63529_solr
   [junit4]   2> 1880084 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1880088 INFO  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1880088 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1880089 INFO  
(zkCallback-4086-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1880097 INFO  
(zkCallback-4088-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1880111 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63528_solr
   [junit4]   2> 1880131 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63530_solr
   [junit4]   2> 1880132 INFO  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1880132 INFO  
(zkCallback-4088-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1880133 INFO  
(zkCallback-4086-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1880134 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1880153 INFO  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1880153 INFO  
(zkCallback-4088-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1880154 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1880155 INFO  
(zkCallback-4086-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1880215 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:63527_solr
   [junit4]   2> 1880218 INFO  
(zkCallback-4088-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1880218 INFO  
(zkCallback-4086-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1880219 INFO  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1880221 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1881111 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63527.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881161 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63528.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881179 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63529.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881193 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63530.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881216 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63528.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881219 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63528.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881244 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63527.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881245 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63527.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881245 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63529.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881245 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63529.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881251 INFO  (jetty-launcher-4066-thread-2) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node2/.
   [junit4]   2> 1881264 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63530.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881264 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63530.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1881268 INFO  (jetty-launcher-4066-thread-3) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node3/.
   [junit4]   2> 1881269 INFO  (jetty-launcher-4066-thread-1) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node1/.
   [junit4]   2> 1881271 INFO  (jetty-launcher-4066-thread-4) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node4/.
   [junit4]   2> 1881680 INFO  (zkConnectionManagerCallback-4111-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1881686 INFO  (zkConnectionManagerCallback-4115-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1881689 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1881691 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[A2C5D2C034449E0E]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63524/solr ready
   [junit4]   2> 1881782 INFO  
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteCollection-seed#[A2C5D2C034449E0E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateAndDeleteCollection
   [junit4]   2> 1881792 INFO  (qtp1557488279-18486) [n:127.0.0.1:63527_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=solrj_test&nrtReplicas=2&action=CREATE&numShards=2&stateFormat=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1881795 INFO  
(OverseerThreadFactory-8819-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
solrj_test
   [junit4]   2> 1881978 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_test",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"solrj_test_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63529/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1882027 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_test",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"solrj_test_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63528/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1882053 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_test",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"solrj_test_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63530/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1882107 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_test",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"solrj_test_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63527/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1882350 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_test_shard1_replica_n1&action=CREATE&numShards=2&collection=solrj_test&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1882350 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=solrj_test_shard2_replica_n6&action=CREATE&numShards=2&collection=solrj_test&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1882352 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1882354 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1882356 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_test_shard1_replica_n2&action=CREATE&numShards=2&collection=solrj_test&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1882356 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=solrj_test_shard2_replica_n4&action=CREATE&numShards=2&collection=solrj_test&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1882357 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1882357 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1883436 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1883437 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1883441 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1883443 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1883508 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.s.IndexSchema [solrj_test_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1883508 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.s.IndexSchema [solrj_test_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 1883514 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1883514 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_test_shard2_replica_n4' using 
configuration from collection solrj_test, trusted=true
   [junit4]   2> 1883517 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.s.IndexSchema [solrj_test_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1883518 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1883519 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_test_shard1_replica_n1' using 
configuration from collection solrj_test, trusted=true
   [junit4]   2> 1883525 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63529.solr.core.solrj_test.shard1.replica_n1' (registry 
'solr.core.solrj_test.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1883525 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1883525 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.SolrCore [[solrj_test_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node4/solrj_test_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node4/./solrj_test_shard1_replica_n1/data/]
   [junit4]   2> 1883519 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1883526 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_test_shard2_replica_n6' using 
configuration from collection solrj_test, trusted=true
   [junit4]   2> 1883527 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63527.solr.core.solrj_test.shard2.replica_n6' (registry 
'solr.core.solrj_test.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1883527 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1883527 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.SolrCore [[solrj_test_shard2_replica_n6] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node2/solrj_test_shard2_replica_n6],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node2/./solrj_test_shard2_replica_n6/data/]
   [junit4]   2> 1883547 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.s.IndexSchema [solrj_test_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1883551 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63530.solr.core.solrj_test.shard2.replica_n4' (registry 
'solr.core.solrj_test.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1883551 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1883552 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.SolrCore [[solrj_test_shard2_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node1/solrj_test_shard2_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node1/./solrj_test_shard2_replica_n4/data/]
   [junit4]   2> 1883554 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1883554 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_test_shard1_replica_n2' using 
configuration from collection solrj_test, trusted=true
   [junit4]   2> 1883554 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_63528.solr.core.solrj_test.shard1.replica_n2' (registry 
'solr.core.solrj_test.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1883554 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1883555 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.SolrCore [[solrj_test_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node3/solrj_test_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node3/./solrj_test_shard1_replica_n2/data/]
   [junit4]   2> 1883947 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1883947 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1883952 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1883952 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1883961 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1883961 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1883966 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1883966 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1883967 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@70571070[solrj_test_shard1_replica_n1] main]
   [junit4]   2> 1883968 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1883968 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1883970 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1883971 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1883971 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1883971 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1883973 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1883973 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594131775824592896
   [junit4]   2> 1883975 INFO  
(searcherExecutor-8829-thread-1-processing-n:127.0.0.1:63529_solr 
x:solrj_test_shard1_replica_n1 s:shard1 c:solrj_test r:core_node3) 
[n:127.0.0.1:63529_solr c:solrj_test s:shard1 r:core_node3 
x:solrj_test_shard1_replica_n1] o.a.s.c.SolrCore [solrj_test_shard1_replica_n1] 
Registered new searcher Searcher@70571070[solrj_test_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1883976 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4e0606c5[solrj_test_shard2_replica_n4] main]
   [junit4]   2> 1883976 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1883977 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1883979 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1883980 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1883980 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@f2163e2[solrj_test_shard1_replica_n2] main]
   [junit4]   2> 1883981 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1883982 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1883983 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@42f6e491[solrj_test_shard2_replica_n6] main]
   [junit4]   2> 1883983 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1883985 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1883985 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594131775837175808
   [junit4]   2> 1883986 INFO  
(searcherExecutor-8828-thread-1-processing-n:127.0.0.1:63530_solr 
x:solrj_test_shard2_replica_n4 s:shard2 c:solrj_test r:core_node7) 
[n:127.0.0.1:63530_solr c:solrj_test s:shard2 r:core_node7 
x:solrj_test_shard2_replica_n4] o.a.s.c.SolrCore [solrj_test_shard2_replica_n4] 
Registered new searcher Searcher@4e0606c5[solrj_test_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1883986 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1883986 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1883987 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1883987 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1883988 INFO  
(searcherExecutor-8831-thread-1-processing-n:127.0.0.1:63528_solr 
x:solrj_test_shard1_replica_n2 s:shard1 c:solrj_test r:core_node5) 
[n:127.0.0.1:63528_solr c:solrj_test s:shard1 r:core_node5 
x:solrj_test_shard1_replica_n2] o.a.s.c.SolrCore [solrj_test_shard1_replica_n2] 
Registered new searcher Searcher@f2163e2[solrj_test_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1883988 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594131775840321536
   [junit4]   2> 1883989 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1883989 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1594131775841370112
   [junit4]   2> 1883990 INFO  
(searcherExecutor-8830-thread-1-processing-n:127.0.0.1:63527_solr 
x:solrj_test_shard2_replica_n6 s:shard2 c:solrj_test r:core_node8) 
[n:127.0.0.1:63527_solr c:solrj_test s:shard2 r:core_node8 
x:solrj_test_shard2_replica_n6] o.a.s.c.SolrCore [solrj_test_shard2_replica_n6] 
Registered new searcher Searcher@42f6e491[solrj_test_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1884000 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard1 to Terms{values={core_node5=0}, version=0}
   [junit4]   2> 1884000 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Failed to save terms, version is not match, retrying
   [junit4]   2> 1884001 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard2 to Terms{values={core_node8=0}, version=0}
   [junit4]   2> 1884003 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard1 to Terms{values={core_node3=0, 
core_node5=0}, version=1}
   [junit4]   2> 1884004 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard2 to Terms{values={core_node7=0, 
core_node8=0}, version=1}
   [junit4]   2> 1884013 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1884014 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1884014 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63530/solr/solrj_test_shard2_replica_n4/
   [junit4]   2> 1884015 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.PeerSync PeerSync: core=solrj_test_shard2_replica_n4 
url=http://127.0.0.1:63530/solr START 
replicas=[http://127.0.0.1:63527/solr/solrj_test_shard2_replica_n6/] 
nUpdates=100
   [junit4]   2> 1884020 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1884020 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1884020 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:63529/solr/solrj_test_shard1_replica_n1/
   [junit4]   2> 1884021 INFO  (qtp1557488279-18493) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.c.S.Request [solrj_test_shard2_replica_n6]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 1884022 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=solrj_test_shard1_replica_n1 
url=http://127.0.0.1:63529/solr START 
replicas=[http://127.0.0.1:63528/solr/solrj_test_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 1884025 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.c.S.Request [solrj_test_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1884326 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.u.PeerSync PeerSync: core=solrj_test_shard2_replica_n4 
url=http://127.0.0.1:63530/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1884326 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 1884326 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
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> 1884326 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1884329 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=solrj_test_shard1_replica_n1 
url=http://127.0.0.1:63529/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1884330 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 1884330 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
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> 1884330 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1884343 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:63529/solr/solrj_test_shard1_replica_n1/ shard1
   [junit4]   2> 1884354 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:63530/solr/solrj_test_shard2_replica_n4/ shard2
   [junit4]   2> 1884483 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1884514 INFO  (qtp1346428778-18488) [n:127.0.0.1:63530_solr 
c:solrj_test s:shard2 r:core_node7 x:solrj_test_shard2_replica_n4] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=solrj_test_shard2_replica_n4&action=CREATE&numShards=2&collection=solrj_test&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2157
   [junit4]   2> 1884521 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1884529 INFO  (qtp700741759-18495) [n:127.0.0.1:63529_solr 
c:solrj_test s:shard1 r:core_node3 x:solrj_test_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_test_shard1_replica_n1&action=CREATE&numShards=2&collection=solrj_test&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2179
   [junit4]   2> 1885049 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr 
c:solrj_test s:shard2 r:core_node8 x:solrj_test_shard2_replica_n6] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=solrj_test_shard2_replica_n6&action=CREATE&numShards=2&collection=solrj_test&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2699
   [junit4]   2> 1885050 INFO  (qtp311698503-18485) [n:127.0.0.1:63528_solr 
c:solrj_test s:shard1 r:core_node5 x:solrj_test_shard1_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_test_shard1_replica_n2&action=CREATE&numShards=2&collection=solrj_test&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2694
   [junit4]   2> 1885056 INFO  (qtp1557488279-18486) [n:127.0.0.1:63527_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> 1885800 INFO  
(OverseerCollectionConfigSetProcessor-72085126833963020-127.0.0.1:63527_solr-n_0000000000)
 [n:127.0.0.1:63527_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1886072 INFO  (qtp1557488279-18486) [n:127.0.0.1:63527_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=2&collection.configName=conf&name=solrj_test&nrtReplicas=2&action=CREATE&numShards=2&stateFormat=1&wt=javabin&version=2}
 status=0 QTime=4280
   [junit4]   2> 1886074 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=solrj_test&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 1886077 INFO  
(OverseerThreadFactory-8819-thread-2-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Executing Collection 
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true, asyncId=null
   [junit4]   2> 1886079 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard1.replica_n2, tag=null
   [junit4]   2> 1886079 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@38616db3: rootName = 
solr_63528, domain = solr.core.solrj_test.shard1.replica_n2, service url = 
null, agent id = null] for registry solr.core.solrj_test.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@7c230775
   [junit4]   2> 1886079 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard2.replica_n4, tag=null
   [junit4]   2> 1886079 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2e7eadd3: rootName = 
solr_63530, domain = solr.core.solrj_test.shard2.replica_n4, service url = 
null, agent id = null] for registry solr.core.solrj_test.shard2.replica_n4 / 
com.codahale.metrics.MetricRegistry@546424a5
   [junit4]   2> 1886080 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard1.replica_n1, tag=null
   [junit4]   2> 1886080 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e36a032: rootName = 
solr_63529, domain = solr.core.solrj_test.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.solrj_test.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@2a2a5964
   [junit4]   2> 1886090 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard2.replica_n6, tag=null
   [junit4]   2> 1886090 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@cb613e4: rootName = 
solr_63527, domain = solr.core.solrj_test.shard2.replica_n6, service url = 
null, agent id = null] for registry solr.core.solrj_test.shard2.replica_n6 / 
com.codahale.metrics.MetricRegistry@3e6f670b
   [junit4]   2> 1886188 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.c.SolrCore [solrj_test_shard2_replica_n6]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6cfa5aed
   [junit4]   2> 1886188 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard2.replica_n6, tag=1828346605
   [junit4]   2> 1886188 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.solrj_test.shard2.leader, tag=1828346605
   [junit4]   2> 1886199 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.c.SolrCore [solrj_test_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1414d4bf
   [junit4]   2> 1886199 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard1.replica_n2, tag=336909503
   [junit4]   2> 1886199 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.solrj_test.shard1.leader, tag=336909503
   [junit4]   2> 1886209 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.c.SolrCore [solrj_test_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2a60f0b4
   [junit4]   2> 1886209 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard1.replica_n1, tag=710996148
   [junit4]   2> 1886209 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.solrj_test.shard1.leader, tag=710996148
   [junit4]   2> 1886210 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.c.SolrCore [solrj_test_shard2_replica_n4]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6a7fd7b2
   [junit4]   2> 1886210 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.solrj_test.shard2.replica_n4, tag=1786763186
   [junit4]   2> 1886210 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.solrj_test.shard2.leader, tag=1786763186
   [junit4]   2> 1886237 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard2 to Terms{values={core_node7=0}, version=2}
   [junit4]   2> 1886238 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader 
parent node, won't remove previous leader registration.
   [junit4]   2> 1886240 INFO  (qtp1557488279-18491) [n:127.0.0.1:63527_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=solrj_test_shard2_replica_n6&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=159
   [junit4]   2> 1886261 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard1 to Terms{values={core_node3=0}, version=2}
   [junit4]   2> 1886272 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard2 to Terms{values={}, version=3}
   [junit4]   2> 1886273 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.c.ShardLeaderElectionContextBase No version found for ephemeral leader 
parent node, won't remove previous leader registration.
   [junit4]   2> 1886274 WARN  
(zkCallback-4103-thread-2-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.LeaderElector Our node is no longer in 
line to be leader
   [junit4]   2> 1886274 INFO  (qtp1346428778-18509) [n:127.0.0.1:63530_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=solrj_test_shard2_replica_n4&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=195
   [junit4]   2> 1886275 INFO  (qtp311698503-18498) [n:127.0.0.1:63528_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=solrj_test_shard1_replica_n2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=197
   [junit4]   2> 1886286 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.c.ZkShardTerms Successful update terms at 
/collections/solrj_test/terms/shard1 to Terms{values={}, version=3}
   [junit4]   2> 1886287 WARN  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.LeaderElector Our node is no longer in 
line to be leader
   [junit4]   2> 1886288 INFO  (qtp700741759-18502) [n:127.0.0.1:63529_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=solrj_test_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=210
   [junit4]   2> 1887067 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=solrj_test&action=DELETE&wt=javabin&version=2} status=0 QTime=993
   [junit4]   2> 1887079 INFO  (qtp1557488279-18493) [n:127.0.0.1:63527_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=solrj_newstateformat&nrtReplicas=2&action=CREATE&numShards=2&stateFormat=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1887089 INFO  
(OverseerThreadFactory-8819-thread-3-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
solrj_newstateformat
   [junit4]   2> 1887092 INFO  
(OverseerCollectionConfigSetProcessor-72085126833963020-127.0.0.1:63527_solr-n_0000000000)
 [n:127.0.0.1:63527_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1887342 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_newstateformat",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"solrj_newstateformat_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63527/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1887356 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_newstateformat",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"solrj_newstateformat_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63529/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1887365 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_newstateformat",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"solrj_newstateformat_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63530/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1887369 INFO  
(OverseerStateUpdate-72085126833963020-127.0.0.1:63527_solr-n_0000000000) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_newstateformat",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"solrj_newstateformat_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:63528/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1887584 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_newstateformat_shard1_replica_n1&action=CREATE&numShards=2&collection=solrj_newstateformat&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1887585 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_newstateformat_shard1_replica_n2&action=CREATE&numShards=2&collection=solrj_newstateformat&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1887585 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=solrj_newstateformat_shard2_replica_n4&action=CREATE&numShards=2&collection=solrj_newstateformat&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1887586 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=solrj_newstateformat_shard2_replica_n6&action=CREATE&numShards=2&collection=solrj_newstateformat&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1887715 INFO  
(zkCallback-4096-thread-1-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887715 INFO  
(zkCallback-4088-thread-1-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887715 INFO  
(zkCallback-4086-thread-1-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887715 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887715 INFO  
(zkCallback-4103-thread-2-processing-n:127.0.0.1:63527_solr) 
[n:127.0.0.1:63527_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887716 INFO  
(zkCallback-4096-thread-2-processing-n:127.0.0.1:63528_solr) 
[n:127.0.0.1:63528_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887718 INFO  
(zkCallback-4086-thread-2-processing-n:127.0.0.1:63530_solr) 
[n:127.0.0.1:63530_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1887719 INFO  
(zkCallback-4088-thread-2-processing-n:127.0.0.1:63529_solr) 
[n:127.0.0.1:63529_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_newstateformat/state.json] for collection 
[solrj_newstateformat] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1888624 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 8.0.0
   [junit4]   2> 1888624 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 8.0.0
   [junit4]   2> 1888675 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.s.IndexSchema 
[solrj_newstateformat_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1888678 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 8.0.0
   [junit4]   2> 1888680 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 1888680 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.c.CoreContainer Creating 
SolrCore 'solrj_newstateformat_shard2_replica_n6' using configuration from 
collection solrj_newstateformat, trusted=true
   [junit4]   2> 1888680 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_63528.solr.core.solrj_newstateformat.shard2.replica_n6' 
(registry 'solr.core.solrj_newstateformat.shard2.replica_n6') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1888680 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1888680 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.c.SolrCore 
[[solrj_newstateformat_shard2_replica_n6] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node3/solrj_newstateformat_shard2_replica_n6],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node3/./solrj_newstateformat_shard2_replica_n6/data/]
   [junit4]   2> 1888688 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 8.0.0
   [junit4]   2> 1888689 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.s.IndexSchema 
[solrj_newstateformat_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1888690 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.s.IndexSchema 
[solrj_newstateformat_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1888692 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 1888693 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.c.CoreContainer Creating 
SolrCore 'solrj_newstateformat_shard1_replica_n1' using configuration from 
collection solrj_newstateformat, trusted=true
   [junit4]   2> 1888693 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 1888693 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.c.CoreContainer Creating 
SolrCore 'solrj_newstateformat_shard1_replica_n2' using configuration from 
collection solrj_newstateformat, trusted=true
   [junit4]   2> 1888693 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_63527.solr.core.solrj_newstateformat.shard1.replica_n1' 
(registry 'solr.core.solrj_newstateformat.shard1.replica_n1') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1888693 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_63529.solr.core.solrj_newstateformat.shard1.replica_n2' 
(registry 'solr.core.solrj_newstateformat.shard1.replica_n2') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1888693 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1888693 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.c.SolrCore 
[[solrj_newstateformat_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node2/solrj_newstateformat_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node2/./solrj_newstateformat_shard1_replica_n1/data/]
   [junit4]   2> 1888694 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1888694 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.c.SolrCore 
[[solrj_newstateformat_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node4/solrj_newstateformat_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node4/./solrj_newstateformat_shard1_replica_n2/data/]
   [junit4]   2> 1888699 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.s.IndexSchema 
[solrj_newstateformat_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 1888702 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 1888702 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.c.CoreContainer Creating 
SolrCore 'solrj_newstateformat_shard2_replica_n4' using configuration from 
collection solrj_newstateformat, trusted=true
   [junit4]   2> 1888702 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_63530.solr.core.solrj_newstateformat.shard2.replica_n4' 
(registry 'solr.core.solrj_newstateformat.shard2.replica_n4') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@23bb9459
   [junit4]   2> 1888703 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1888703 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.c.SolrCore 
[[solrj_newstateformat_shard2_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node1/solrj_newstateformat_shard2_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_A2C5D2C034449E0E-001/tempDir-001/node1/./solrj_newstateformat_shard2_replica_n4/data/]
   [junit4]   2> 1889247 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1889247 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1889248 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1889248 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1889250 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1889251 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1889255 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1889255 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1889261 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1889261 INFO  (qtp700741759-18514) [n:127.0.0.1:63529_solr 
c:solrj_newstateformat s:shard1 r:core_node5 
x:solrj_newstateformat_shard1_replica_n2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1889264 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1889264 INFO  (qtp311698503-18500) [n:127.0.0.1:63528_solr 
c:solrj_newstateformat s:shard2 r:core_node8 
x:solrj_newstateformat_shard2_replica_n6] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1889279 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1889280 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1889282 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1889282 INFO  (qtp1346428778-18511) [n:127.0.0.1:63530_solr 
c:solrj_newstateformat s:shard2 r:core_node7 
x:solrj_newstateformat_shard2_replica_n4] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1889285 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@46fcb339[solrj_newstateformat_shard1_replica_n1] main]
   [junit4]   2> 1889296 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 1889296 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1889298 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000ms.
   [junit4]   2> 1889299 INFO  (qtp1557488279-18489) [n:127.0.0.1:63527_solr 
c:solrj_newstateformat s:shard1 r:core_node3 
x:solrj_newstateformat_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1594131781409308672
   [junit4]   2> 1889299 INFO  
(searcherExecutor-8849-thread-1-processing-n:127.0.0.1:63527_solr 
x:solrj_newstateformat_shard1_replica_n1 s:shard1 c:solrj_newstateformat 
r:core_node3) [n:127.0.0.1:63527_solr c:solrj_newstateformat s:shard1 
r:core_node3 x:solrj_newstateformat_shard1_replica_n

[...truncated too long message...]

eaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1890, maxMBSortInHeap=6.3148068591078585, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@69f78ac9),
 locale=uk, timezone=America/North_Dakota/Beulah
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=241272672,total=521142272
   [junit4]   2> NOTE: All tests run in this JVM: 
[SimpleCollectionCreateDeleteTest, ConfigureRecoveryStrategyTest, 
SimpleFacetsTest, TestLegacyNumericRangeQueryBuilder, DocValuesMultiTest, 
TestNumericTerms32, AsyncCallRequestStatusResponseTest, TestSolrCloudSnapshots, 
LeaderFailureAfterFreshStartTest, TestTrackingShardHandlerFactory, HLLUtilTest, 
TestPayloadCheckQParserPlugin, TestStressLucene, 
HdfsCollectionsAPIDistributedZkTest, TestMinMaxOnMultiValuedField, 
ScriptEngineTest, TestLeaderInitiatedRecoveryThread, TestSolrIndexConfig, 
TestClusterProperties, TestMultiValuedNumericRangeQuery, PrimUtilsTest, 
URLClassifyProcessorTest, SuggesterWFSTTest, TestStressReorder, 
TestAnalyzedSuggestions, SpellPossibilityIteratorTest, 
DistributedFacetPivotLongTailTest, TestRTGBase, TestManagedResource, 
TestPHPSerializedResponseWriter, SliceStateTest, RegexBytesRefFilterTest, 
BadComponentTest, InfixSuggestersTest, TestNumericRangeQuery64, 
OverseerCollectionConfigSetProcessorTest, FieldAnalysisRequestHandlerTest, 
TestCustomSort, TestStressInPlaceUpdates, TestMiniSolrCloudClusterSSL, 
SaslZkACLProviderTest, ConnectionManagerTest, TestDefaultStatsCache, 
LegacyCloudClusterPropTest, LargeFieldTest, TestRecoveryHdfs, 
TestFieldTypeResource, SearchHandlerTest, HdfsBasicDistributedZkTest, 
TestRawResponseWriter, FileBasedSpellCheckerTest, TestSolrCoreProperties, 
TestDocumentBuilder, TestLegacyField, TestRequestForwarding, V2StandaloneTest, 
ImplicitSnitchTest, HdfsDirectoryFactoryTest, TestCoreDiscovery, 
TestLMDirichletSimilarityFactory, TestXmlQParserPlugin, 
TestSchemaVersionResource, MissingSegmentRecoveryTest, 
AnalysisErrorHandlingTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
CoreMergeIndexesAdminHandlerTest, TestReversedWildcardFilterFactory, 
TestJsonRequest, TestDistributedStatsComponentCardinality, 
TestWordDelimiterFilterFactory, TestSlowCompositeReaderWrapper, DOMUtilTest, 
AutoAddReplicasPlanActionTest, DisMaxRequestHandlerTest, 
HdfsUnloadDistributedZkTest, TestTrieFacet, TestCloudConsistency, 
NotRequiredUniqueKeyTest, TestHdfsBackupRestoreCore, HdfsDirectoryTest, 
TestLuceneIndexBackCompat, MoveReplicaHDFSTest, SolrGraphiteReporterTest, 
PreAnalyzedUpdateProcessorTest, TestBackupRepositoryFactory, 
TestEmbeddedSolrServerConstructors, TestDelegationWithHadoopAuth, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestCrossCoreJoin, 
ZkControllerTest, TestNRTOpen, DirectoryFactoryTest, TestFieldResource, 
SolrCmdDistributorTest, BasicDistributedZk2Test, TestStandardQParsers, 
TestDocTermOrds, RequestHandlersTest, RegexBoostProcessorTest, 
ClassificationUpdateProcessorIntegrationTest, TestExactSharedStatsCache, 
TestRandomFaceting, DistributedDebugComponentTest, TestCSVLoader, 
DistributedSuggestComponentTest, HdfsAutoAddReplicasIntegrationTest, 
WrapperMergePolicyFactoryTest, TestScoreJoinQPNoScore, BasicFunctionalityTest, 
TestTriggerIntegration, TestCustomDocTransformer, 
DistributedFacetExistsSmallTest, DeleteReplicaTest, TestStreamBody, 
TestNodeAddedTrigger, ResponseLogComponentTest, HttpSolrCallGetCoreTest, 
TestSolr4Spatial, TestPullReplicaErrorHandling, TestSolrDeletionPolicy2, 
SyncSliceTest, OverseerTest, SpellCheckComponentTest, DistanceFunctionTest, 
ShufflingReplicaListTransformerTest, TestSearcherReuse, 
TestDynamicFieldResource, TestSolrConfigHandler, TestPrepRecovery, 
TestWriterPerf, DeleteStatusTest, LeaderElectionContextKeyTest, 
TestHalfAndHalfDocValues, OverseerRolesTest, TestSort, UpdateParamsTest, 
SimplePostToolTest, UpdateLogTest, HdfsChaosMonkeySafeLeaderTest, 
TestSolrCloudWithDelegationTokens, TestTlogReplica, SolrCloudReportersTest, 
TestValueSourceCache, PrimitiveFieldTypeTest, UUIDFieldTest, UtilsToolTest, 
TermVectorComponentTest, TestInfoStreamLogging, TestFastLRUCache, 
DateRangeFieldTest, AtomicUpdatesTest, TestMacros, TestExtendedDismaxParser, 
TestGenericDistributedQueue, TestCloudInspectUtil, BadIndexSchemaTest, 
DirectUpdateHandlerTest, TestObjectReleaseTracker, 
TestSizeLimitedDistributedMap, TestCoreAdminApis, TestInPlaceUpdatesDistrib, 
MetricsHandlerTest, ZkShardTermsTest, TestFuzzyAnalyzedSuggestions, 
BasicAuthStandaloneTest, HttpPartitionTest, 
TestCollectionsAPIViaSolrCloudCluster, TestSolrCLIRunExample, 
DistributedQueueTest, UpdateRequestProcessorFactoryTest, 
TestDFRSimilarityFactory, DataDrivenBlockJoinTest, TestQuerySenderListener, 
TestCloudNestedDocsSort, CollectionReloadTest, LoggingHandlerTest, 
TestRestManager, TestConfigReload, TestFieldCacheWithThreads, 
SolrMetricsIntegrationTest, DistributedQueryComponentCustomSortTest, 
CdcrBidirectionalTest, BlockJoinFacetDistribTest, TestSmileRequest, 
TestCloudPivotFacet, ExternalFileFieldSortTest, BitVectorTest, 
TestSortByMinMaxFunction, VMParamsZkACLAndCredentialsProvidersTest, 
TestDownShardTolerantSearch, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, 
OpenCloseCoreStressTest, LeaderElectionIntegrationTest, ShardRoutingTest, 
BasicZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, 
ZkSolrClientTest, TestRandomDVFaceting, ShardRoutingCustomTest, 
TestDistributedGrouping, TestFaceting, TestHashPartitioner, 
DistributedSpellCheckComponentTest, TestReload, TestRangeQuery, 
StatsComponentTest, TestFiltering, TestLazyCores, TestIndexSearcher, 
ShowFileRequestHandlerTest, SolrIndexSplitterTest, SpellCheckCollatorTest, 
SuggesterFSTTest, CoreAdminHandlerTest, SolrRequestParserTest, DocValuesTest, 
SuggesterTSTTest, SuggesterTest, TestTrie, SpatialFilterTest, PolyFieldTest, 
NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, TestUpdate, TestAtomicUpdateErrorCases, 
QueryEqualityTest, DirectUpdateHandlerOptimizeTest, 
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, 
SortByFunctionTest, XsltUpdateRequestHandlerTest, DebugComponentTest, 
CacheHeaderTest, IndexBasedSpellCheckerTest, TestSurroundQueryParser, 
LukeRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, 
XmlUpdateRequestHandlerTest, DocumentBuilderTest, TestIndexingPerformance, 
MoreLikeThisHandlerTest, TestSolrQueryParser, IndexSchemaRuntimeFieldTest, 
IndexSchemaTest, TestJmxIntegration, TestCollationField, ReturnFieldsTest, 
TestCSVResponseWriter, QueryParsingTest, JsonLoaderTest, 
BinaryUpdateRequestHandlerTest, CSVRequestHandlerTest, TestComponentsName, 
SearchHandlerTest, TestLFUCache, HighlighterConfigTest, AlternateDirectoryTest, 
CopyFieldTest, TestStressRecovery, TestLuceneMatchVersion, TestCharFilters, 
EchoParamsTest, TestSweetSpotSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, 
TimeZoneUtilsTest, DateMathParserTest, PreAnalyzedFieldTest, 
TestSuggestSpellingConverter, ClusterStateTest, TestLRUCache, 
SystemInfoHandlerTest, FileUtilsTest, CircularListTest, 
DistributedMLTComponentTest, CursorPagingTest, DistributedIntervalFacetingTest, 
SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, 
TestSimpleTrackingShardHandler, TestJettySolrRunner, ActionThrottleTest, 
AliasIntegrationTest, ChaosMonkeySafeLeaderWithPullReplicasTest, 
CleanupOldIndexTest, CollectionsAPISolrJTest]
   [junit4] Completed [533/780 (1!)] on J1 in 99.23s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 46768 lines...]
-ecj-javadoc-lint-src:
    [mkdir] Created dir: 
/var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj223563859
 [ecj-lint] Compiling 1166 source files to 
/var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj223563859
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. ERROR in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/java/org/apache/solr/search/facet/FacetModule.java
 (at line 44)
 [ecj-lint]     import org.noggit.JSONUtil;
 [ecj-lint]            ^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The import org.noggit.JSONUtil is never used
 [ecj-lint] ----------
 [ecj-lint] 1 problem (1 error)

BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:618: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:101: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build.xml:682: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:2082:
 The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:2121:
 Compile failed; see the compiler error output for details.

Total time: 90 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to