You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/06/03 16:16:05 UTC
[JENKINS] Lucene-Solr-master-Windows (64bit/jdk1.8.0_92) - Build #
5889 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/5889/
Java: 64bit/jdk1.8.0_92 -XX:+UseCompressedOops -XX:+UseParallelGC
3 tests failed.
FAILED: org.apache.solr.cloud.TestCloudBackupRestore.test
Error Message:
Error from server at https://127.0.0.1:51583/solr: Collection 'backuprestore_restored' exists, no action taken.
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:51583/solr: Collection 'backuprestore_restored' exists, no action taken.
at __randomizedtesting.SeedInfo.seed([86F42493D4A1E4D6:EA01B497A5D892E]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:606)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:413)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:366)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1228)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:998)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:934)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:166)
at org.apache.solr.cloud.TestCloudBackupRestore.testBackupAndRestore(TestCloudBackupRestore.java:178)
at org.apache.solr.cloud.TestCloudBackupRestore.test(TestCloudBackupRestore.java:110)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at __randomizedtesting.SeedInfo.seed([86F42493D4A1E4D6:F96A9316BDC3C95C]:0)
at org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1200)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:125)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:53)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExample
Error Message:
Expected 10 to be found in the testCloudExamplePrompt collection but only found 3
Stack Trace:
java.lang.AssertionError: Expected 10 to be found in the testCloudExamplePrompt collection but only found 3
at __randomizedtesting.SeedInfo.seed([86F42493D4A1E4D6:5D85C459E3D421B0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExample(TestSolrCLIRunExample.java:457)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10725 lines...]
[junit4] Suite: org.apache.solr.util.TestSolrCLIRunExample
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\init-core-data-001
[junit4] 2> 342308 INFO (SUITE-TestSolrCLIRunExample-seed#[86F42493D4A1E4D6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 342311 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInteractiveSolrCloudExample
[junit4] 2> 348903 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 348904 INFO (Thread-876) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 348904 INFO (Thread-876) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 349005 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.ZkTestServer start zk server on port:50098
[junit4] 2> 349005 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 349006 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 349014 INFO (zkCallback-359-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@551624f4 name:ZooKeeperConnection Watcher:127.0.0.1:50098 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 349014 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 349016 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 349016 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 349022 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15516e95a280000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 349027 INFO (jetty-launcher-358-thread-1) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 349028 INFO (jetty-launcher-358-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@441b777d{/solr,null,AVAILABLE}
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@1d46acdf{HTTP/1.1,[http/1.1]}{127.0.0.1:50086}
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.e.j.s.Server Started @353013ms
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50086}
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1'
[junit4] 2> 349029 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 349031 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 349032 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 349036 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 349039 INFO (zkCallback-360-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4438bea5 name:ZooKeeperConnection Watcher:127.0.0.1:50098/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 349039 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 349039 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 349040 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 349053 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1
[junit4] 2> 349053 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15516e95a280001, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 349053 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 1093839636
[junit4] 2> 349054 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1]
[junit4] 2> 349054 WARN (jetty-launcher-358-thread-1) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\lib
[junit4] 2> 349054 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 349058 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
[junit4] 2> 349059 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 349059 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 349059 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50098/solr
[junit4] 2> 349059 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 349060 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 349061 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 349073 INFO (zkCallback-363-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@150521bb name:ZooKeeperConnection Watcher:127.0.0.1:50098 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 349074 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 349074 INFO (jetty-launcher-358-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 349077 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15516e95a280002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 349081 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$36/1730495594@36c827d9
[junit4] 2> 349083 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 349142 INFO (zkCallback-364-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@624fd561 name:ZooKeeperConnection Watcher:127.0.0.1:50098/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 349142 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 349146 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 349149 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 349155 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 349158 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 349160 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 349161 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 349163 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 349164 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 349165 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 349166 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 349167 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 349168 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 349168 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 349171 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 349172 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 349173 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 349174 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96008158554095619-localhost:50086_solr-n_0000000000
[junit4] 2> 349174 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader localhost:50086_solr
[junit4] 2> 349174 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 349174 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.Overseer Overseer (id=96008158554095619-localhost:50086_solr-n_0000000000) starting
[junit4] 2> 349177 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 349183 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 349184 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/localhost:50086_solr
[junit4] 2> 349185 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/localhost:50086_solr
[junit4] 2> 349198 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 349198 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 349200 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1
[junit4] 2> 349200 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions
[junit4] 2> 349201 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1
[junit4] 2> 349201 INFO (jetty-launcher-358-thread-1) [n:localhost:50086_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 349201 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 349206 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 349208 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 349214 INFO (zkCallback-364-thread-2-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0])
[junit4] 2> 349217 INFO (OverseerCollectionConfigSetProcessor-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 349219 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 349222 INFO (zkCallback-366-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@25e13ecc name:ZooKeeperConnection Watcher:127.0.0.1:50098 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 349222 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 349223 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 349228 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.s.i.CloudSolrClient Final constructed zkHost string: 127.0.0.1:50098/solr
[junit4] 2> 352603 INFO (qtp592568807-2585) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=344
[junit4] 2> 352623 INFO (qtp592568807-2585) [n:localhost:50086_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
[junit4] 2> 352628 INFO (qtp592568807-2585) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=6
[junit4] 2> 352634 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.s.i.CloudSolrClient Final constructed zkHost string: 127.0.0.1:50098/solr
[junit4] 2> 352636 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 352637 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 352642 INFO (zkCallback-370-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@474e5ba8 name:ZooKeeperConnection Watcher:127.0.0.1:50098/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 352643 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 352643 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 352643 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 352643 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 352644 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 352646 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15516e95a280005, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 352651 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json and sendToOCPQueue=true
[junit4] 2> 352651 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 352674 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=12
[junit4] 2> 352682 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
[junit4] 2> 352683 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=1
[junit4] 2> 352683 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.s.i.CloudSolrClient Final constructed zkHost string: 127.0.0.1:50098/solr
[junit4] 2> 352685 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 352688 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 352699 INFO (zkCallback-373-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d0c1d2b name:ZooKeeperConnection Watcher:127.0.0.1:50098/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 352701 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 352701 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 352701 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 352701 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 352701 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 352706 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/currency.xml
[junit4] 2> 352711 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/elevate.xml
[junit4] 2> 352714 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_ca.txt
[junit4] 2> 352719 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_fr.txt
[junit4] 2> 352723 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_ga.txt
[junit4] 2> 352726 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_it.txt
[junit4] 2> 352730 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/hyphenations_ga.txt
[junit4] 2> 352734 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stemdict_nl.txt
[junit4] 2> 352738 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stoptags_ja.txt
[junit4] 2> 352742 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ar.txt
[junit4] 2> 352745 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_bg.txt
[junit4] 2> 352748 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ca.txt
[junit4] 2> 352751 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_cz.txt
[junit4] 2> 352754 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_da.txt
[junit4] 2> 352757 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_de.txt
[junit4] 2> 352760 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_el.txt
[junit4] 2> 352762 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_en.txt
[junit4] 2> 352766 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_es.txt
[junit4] 2> 352769 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_eu.txt
[junit4] 2> 352772 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fa.txt
[junit4] 2> 352775 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fi.txt
[junit4] 2> 352778 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fr.txt
[junit4] 2> 352781 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ga.txt
[junit4] 2> 352784 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_gl.txt
[junit4] 2> 352787 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hi.txt
[junit4] 2> 352790 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hu.txt
[junit4] 2> 352793 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hy.txt
[junit4] 2> 352797 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_id.txt
[junit4] 2> 352802 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_it.txt
[junit4] 2> 352806 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ja.txt
[junit4] 2> 352810 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_lv.txt
[junit4] 2> 352814 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_nl.txt
[junit4] 2> 352817 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_no.txt
[junit4] 2> 352821 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_pt.txt
[junit4] 2> 352824 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ro.txt
[junit4] 2> 352827 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ru.txt
[junit4] 2> 352831 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_sv.txt
[junit4] 2> 352834 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_th.txt
[junit4] 2> 352839 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_tr.txt
[junit4] 2> 352842 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/userdict_ja.txt
[junit4] 2> 352846 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 352850 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/params.json
[junit4] 2> 352854 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/protwords.txt
[junit4] 2> 352858 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/solrconfig.xml
[junit4] 2> 352862 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/stopwords.txt
[junit4] 2> 352865 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/synonyms.txt
[junit4] 2> 352870 INFO (qtp592568807-2588) [n:localhost:50086_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json and sendToOCPQueue=true
[junit4] 2> 352870 INFO (qtp592568807-2588) [n:localhost:50086_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 352875 INFO (qtp592568807-2595) [n:localhost:50086_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&maxShardsPerNode=4&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt&action=CREATE&numShards=2&wt=json and sendToOCPQueue=true
[junit4] 2> 352878 INFO (OverseerCollectionConfigSetProcessor-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.OverseerTaskProcessor Overseer Collection Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 352879 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler OverseerCollectionMessageHandler.processMessage : create , {
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 352879 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Create collection testCloudExamplePrompt
[junit4] 2> 352880 WARN (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Specified replicationFactor of 2 on collection testCloudExamplePrompt is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 352880 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler creating collections conf node /collections/testCloudExamplePrompt
[junit4] 2> 352880 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.SolrZkClient makePath: /collections/testCloudExamplePrompt
[junit4] 2> 352882 INFO (zkCallback-364-thread-2-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 352882 INFO (zkCallback-373-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 352886 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 352887 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: testCloudExamplePrompt
[junit4] 2> 352888 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testCloudExamplePrompt/state.json
[junit4] 2> 352998 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating SolrCores for new collection testCloudExamplePrompt, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 352998 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard2_replica1 as part of shard shard2 of collection testCloudExamplePrompt on localhost:50086_solr
[junit4] 2> 352998 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard2_replica2 as part of shard shard2 of collection testCloudExamplePrompt on localhost:50086_solr
[junit4] 2> 352998 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard1_replica2 as part of shard shard1 of collection testCloudExamplePrompt on localhost:50086_solr
[junit4] 2> 352998 INFO (OverseerThreadFactory-1093-thread-1-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard1_replica1 as part of shard shard1 of collection testCloudExamplePrompt on localhost:50086_solr
[junit4] 2> 353004 INFO (qtp592568807-2591) [n:localhost:50086_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard2_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 353006 INFO (qtp592568807-2585) [n:localhost:50086_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard1_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 353006 INFO (qtp592568807-2591) [n:localhost:50086_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testCloudExamplePrompt_shard2_replica1, collection.configName=testCloudExamplePrompt, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testCloudExamplePrompt, numShards=2, dataDir=data\, shard=shard2}
[junit4] 2> 353007 INFO (qtp592568807-2585) [n:localhost:50086_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testCloudExamplePrompt_shard1_replica2, collection.configName=testCloudExamplePrompt, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testCloudExamplePrompt, numShards=2, dataDir=data\, shard=shard1}
[junit4] 2> 353010 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard2_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 353011 INFO (qtp592568807-2592) [n:localhost:50086_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testCloudExamplePrompt_shard2_replica2, collection.configName=testCloudExamplePrompt, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testCloudExamplePrompt, numShards=2, dataDir=data\, shard=shard2}
[junit4] 2> 353011 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 353012 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController publishing state=down
[junit4] 2> 353012 INFO (qtp592568807-2589) [n:localhost:50086_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard1_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 353012 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController publishing state=down
[junit4] 2> 353013 INFO (qtp592568807-2589) [n:localhost:50086_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testCloudExamplePrompt_shard1_replica1, collection.configName=testCloudExamplePrompt, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testCloudExamplePrompt, numShards=2, dataDir=data\, shard=shard1}
[junit4] 2> 353013 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Registering watch for collection testCloudExamplePrompt
[junit4] 2> 353015 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Registering watch for collection testCloudExamplePrompt
[junit4] 2> 353015 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Waiting for coreNodeName for core testCloudExamplePrompt_shard2_replica2 in collection testCloudExamplePrompt to be assigned
[junit4] 2> 353015 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.c.ZkStateReader Add data for [testCloudExamplePrompt] ver [0]
[junit4] 2> 353015 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 353015 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Waiting for coreNodeName for core testCloudExamplePrompt_shard2_replica1 in collection testCloudExamplePrompt to be assigned
[junit4] 2> 353015 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Registering watch for collection testCloudExamplePrompt
[junit4] 2> 353015 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Waiting for coreNodeName for core testCloudExamplePrompt_shard1_replica2 in collection testCloudExamplePrompt to be assigned
[junit4] 2> 353016 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Registering watch for collection testCloudExamplePrompt
[junit4] 2> 353016 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Waiting for coreNodeName for core testCloudExamplePrompt_shard1_replica1 in collection testCloudExamplePrompt to be assigned
[junit4] 2> 353016 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 353016 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 353019 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 353019 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 353021 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 353021 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 353024 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 353024 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:50086/solr",
[junit4] 2> "node_name":"localhost:50086_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 353127 INFO (OverseerStateUpdate-96008158554095619-localhost:50086_solr-n_0000000000) [n:localhost:50086_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testCloudExamplePrompt/state.json version: 0
[junit4] 2> 353128 INFO (zkCallback-364-thread-2-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json] for collection [testCloudExamplePrompt] has occurred - updating... (live nodes size: [1])
[junit4] 2> 353129 INFO (zkCallback-364-thread-2-processing-n:localhost:50086_solr) [n:localhost:50086_solr ] o.a.s.c.c.ZkStateReader Updating data for [testCloudExamplePrompt] from [0] to [1]
[junit4] 2> 353130 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard2_replica1
[junit4] 2> 353130 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 353130 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard1_replica1
[junit4] 2> 353130 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 353131 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard1_replica2
[junit4] 2> 353131 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard2_replica2
[junit4] 2> 353131 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 353131 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 353131 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 353131 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/testCloudExamplePrompt]
[junit4] 2> 353131 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 353131 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/testCloudExamplePrompt]
[junit4] 2> 353132 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 353132 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/testCloudExamplePrompt]
[junit4] 2> 353133 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 353133 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/testCloudExamplePrompt]
[junit4] 2> 353134 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.c.ZkStateReader path=[/collections/testCloudExamplePrompt] [configName]=[testCloudExamplePrompt] specified config exists in ZooKeeper
[junit4] 2> 353134 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica1'
[junit4] 2> 353135 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 353135 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 353135 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.c.ZkStateReader path=[/collections/testCloudExamplePrompt] [configName]=[testCloudExamplePrompt] specified config exists in ZooKeeper
[junit4] 2> 353135 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1'
[junit4] 2> 353135 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 353135 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 353137 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.c.ZkStateReader path=[/collections/testCloudExamplePrompt] [configName]=[testCloudExamplePrompt] specified config exists in ZooKeeper
[junit4] 2> 353137 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2'
[junit4] 2> 353138 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 353138 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 353138 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader path=[/collections/testCloudExamplePrompt] [configName]=[testCloudExamplePrompt] specified config exists in ZooKeeper
[junit4] 2> 353138 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2'
[junit4] 2> 353138 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 353138 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 353146 INFO (qtp592568807-2591) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 353147 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 353159 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 353160 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 353179 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 353181 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 353187 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 353188 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 353188 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 353188 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 353188 INFO (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 353188 INFO (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 353197 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\extraction\lib
[junit4] 2> 353197 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\extraction\lib
[junit4] 2> 353198 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist
[junit4] 2> 353199 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist
[junit4] 2> 353201 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\clustering\lib
[junit4] 2> 353201 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\clustering\lib
[junit4] 2> 353201 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist filtered by solr-clustering-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist
[junit4] 2> 353201 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist filtered by solr-clustering-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist
[junit4] 2> 353202 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 353202 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 353202 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 353202 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\langid\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\langid\lib
[junit4] 2> 353202 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\langid\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\langid\lib
[junit4] 2> 353202 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist filtered by solr-langid-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist
[junit4] 2> 353202 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist filtered by solr-langid-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist
[junit4] 2> 353202 INFO (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 353203 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\velocity\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\contrib\velocity\lib
[junit4] 2> 353203 WARN (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\contrib\extraction\lib
[junit4] 2> 353203 WARN (qtp592568807-2592) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist filtered by solr-velocity-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard2_replica2\..\..\..\..\dist
[junit4] 2> 353204 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\velocity\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\contrib\velocity\lib
[junit4] 2> 353204 WARN (qtp592568807-2585) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist filtered by solr-velocity-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica2\..\..\..\..\dist
[junit4] 2> 353204 WARN (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\dist
[junit4] 2> 353205 WARN (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.util.TestSolrCLIRunExample_86F42493D4A1E4D6-001\tempDir-002\node1\testCloudExamplePrompt_shard1_replica1\..\..\..\..\contrib\clustering\lib
[junit4] 2> 353205 WARN (qtp592568807-2589) [n:localhost:50086_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\wor
[...truncated too long message...]
atchedCollectionCreation-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2308265 INFO (zkCallback-3669-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2308267 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2308268 INFO (zkCallback-3669-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 2308268 INFO (zkCallback-3669-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2308271 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[86F42493D4A1E4D6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57093 57093
[junit4] 2> 2308273 INFO (Thread-6851) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57093 57093
[junit4] 2> 2308274 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[86F42493D4A1E4D6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 2308275 INFO (SUITE-ZkStateReaderTest-seed#[86F42493D4A1E4D6]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.overseer.ZkStateReaderTest_86F42493D4A1E4D6-001
[junit4] 2> Jun 03, 2016 4:09:59 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1546, maxMBSortInHeap=6.061333252333721, sim=ClassicSimilarity, locale=ar-YE, timezone=Atlantic/Azores
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=198896328,total=510656512
[junit4] 2> NOTE: All tests run in this JVM: [DefaultValueUpdateProcessorTest, SpellCheckComponentTest, CacheHeaderTest, DebugComponentTest, TestRebalanceLeaders, DistribDocExpirationUpdateProcessorTest, MultiTermTest, BinaryUpdateRequestHandlerTest, ConfigSetsAPITest, TestClassicSimilarityFactory, TestTrie, SmileWriterTest, SuggestComponentContextFilterQueryTest, TestMissingGroups, DistributedQueryComponentOptimizationTest, BlockJoinFacetRandomTest, HdfsDirectoryTest, DateMathParserTest, BasicZkTest, DeleteReplicaTest, TestDistributedGrouping, TestNumericTerms64, CheckHdfsIndexTest, SolrCmdDistributorTest, NotRequiredUniqueKeyTest, BigEndianAscendingWordDeserializerTest, TestRestoreCore, TestStandardQParsers, SolrPluginUtilsTest, RequestHandlersTest, RAMDirectoryFactoryTest, TestChildDocTransformer, DistributedTermsComponentTest, TestQueryUtils, FacetPivotSmallTest, ParsingFieldUpdateProcessorsTest, TestExclusionRuleCollectionAccess, DirectSolrConnectionTest, TestScoreJoinQPScore, QueryResultKeyTest, LeaderFailoverAfterPartitionTest, TestCharFilters, BitVectorTest, TestSolrCLIRunExample, TestTrieFacet, TestDocBasedVersionConstraints, CollectionTooManyReplicasTest, SuggesterWFSTTest, CleanupOldIndexTest, HdfsChaosMonkeySafeLeaderTest, ZkSolrClientTest, TestRawResponseWriter, TestStressCloudBlindAtomicUpdates, OpenCloseCoreStressTest, RemoteQueryErrorTest, SharedFSAutoReplicaFailoverUtilsTest, GraphQueryTest, TestExactStatsCache, DocExpirationUpdateProcessorFactoryTest, OverseerTaskQueueTest, TestAtomicUpdateErrorCases, TestConfigSets, CdcrUpdateLogTest, BasicFunctionalityTest, DeleteInactiveReplicaTest, TestFieldCacheVsDocValues, TestMiniSolrCloudCluster, TestSchemaVersionResource, HdfsNNFailoverTest, TestInitParams, TestCloudDeleteByQuery, LoggingHandlerTest, TestSolrQueryParserDefaultOperatorResource, TestClusterStateMutator, TestRequestForwarding, TestFiltering, CdcrVersionReplicationTest, TestReversedWildcardFilterFactory, SolrCoreCheckLockOnStartupTest, TestRTGBase, TestTolerantUpdateProcessorCloud, AddSchemaFieldsUpdateProcessorFactoryTest, TestSolrJ, SpellCheckCollatorTest, FullSolrCloudDistribCmdsTest, AutoCommitTest, TestLMJelinekMercerSimilarityFactory, HighlighterConfigTest, OutputWriterTest, CurrencyFieldOpenExchangeTest, DistributedFacetPivotSmallAdvancedTest, HdfsRecoveryZkTest, TestJettySolrRunner, TestUtils, HdfsWriteToMultipleCollectionsTest, TestReplicationHandlerBackup, CollectionsAPIDistributedZkTest, TestZkChroot, TestFieldTypeResource, DistributedIntervalFacetingTest, TestSchemaManager, TestAuthenticationFramework, TestDocTermOrds, TestPivotHelperCode, UpdateRequestProcessorFactoryTest, SignatureUpdateProcessorFactoryTest, TestCSVResponseWriter, TestNamedUpdateProcessors, TestFieldResource, WordBreakSolrSpellCheckerTest, TestSchemaResource, TestFieldCacheReopen, DistributedQueueTest, TestReloadDeadlock, ChaosMonkeySafeLeaderTest, TestObjectReleaseTracker, TestSolr4Spatial, FullHLLTest, LeaderElectionIntegrationTest, ResponseHeaderTest, TestAnalyzeInfixSuggestions, TestQuerySenderListener, TestSolr4Spatial2, CollectionsAPISolrJTest, BasicDistributedZk2Test, TestOverriddenPrefixQueryForCustomFieldType, TestLegacyFieldCache, SortSpecParsingTest, CSVRequestHandlerTest, VMParamsZkACLAndCredentialsProvidersTest, TestRandomFaceting, TestSystemIdResolver, ZkStateWriterTest, TestDistributedStatsComponentCardinality, SSLMigrationTest, BasicAuthIntegrationTest, LeaderInitiatedRecoveryOnShardRestartTest, SolrIndexSplitterTest, TestOrdValues, AsyncCallRequestStatusResponseTest, DistributedFacetPivotWhiteBoxTest, TestDistributedMissingSort, TestLeaderInitiatedRecoveryThread, DistanceFunctionTest, SpellPossibilityIteratorTest, DeleteStatusTest, CoreMergeIndexesAdminHandlerTest, QueryParsingTest, TestBinaryField, RecoveryZkTest, TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch, TestRealTimeGet, TestReload, TestRangeQuery, StatsComponentTest, TestBadConfig, TestIndexSearcher, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, SuggesterTest, TestStressLucene, SpatialFilterTest, PolyFieldTest, NoCacheHeaderTest, TestUpdate, FieldMutatingUpdateProcessorTest, DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, SolrInfoMBeanTest, LukeRequestHandlerTest, TestQueryTypes, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, TestValueSourceCache, TermVectorComponentTest, RequiredFieldsTest, TestArbitraryIndexDir, IndexSchemaTest, ReturnFieldsTest, TestPHPSerializedResponseWriter, SearchHandlerTest, TestBinaryResponseWriter, AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, ResponseLogComponentTest, BadComponentTest, TestStressRecovery, TestMergePolicyConfig, TestSolrDeletionPolicy2, SampleTest, NumericFieldsTest, MinimalSchemaTest, TestConfig, TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, TestLuceneMatchVersion, TestPhraseSuggestions, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter, TestJmxMonitoredMap, ResourceLoaderTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache, PreAnalyzedFieldTest, PrimUtilsTest, TestSuggestSpellingConverter, SpellingQueryConverterTest, TestDocumentBuilder, UUIDFieldTest, CircularListTest, CursorPagingTest, AliasIntegrationTest, CollectionsAPIAsyncDistributedZkTest, DeleteShardTest, LeaderInitiatedRecoveryOnCommitTest, MultiThreadedOCPTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, RestartWhileUpdatingTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SimpleCollectionCreateDeleteTest, SolrCloudExampleTest, SolrXmlInZkTest, TestCloudInspectUtil, TestCloudPivotFacet, TestCollectionAPI, TestConfigSetsAPI, TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, TestCryptoKeys, TestOnReconnectListenerSupport, TestRequestStatusCollectionAPI, TestTolerantUpdateProcessorRandomCloud, TlogReplayBufferedWhileIndexingTest, HdfsBasicDistributedZkTest, HdfsRecoverLeaseTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsTlogReplayBufferedWhileIndexingTest, ZkStateReaderTest]
[junit4] Completed [489/612 (3!)] on J1 in 32.18s, 6 tests, 1 error <<< FAILURES!
[...truncated 382 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:740: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:684: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\common-build.xml:531: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1427: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:984: There were test failures: 612 suites (10 ignored), 2560 tests, 2 errors, 1 failure, 126 ignored (82 assumptions) [seed: 86F42493D4A1E4D6]
Total time: 65 minutes 27 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-master-Windows (32bit/jdk1.8.0_92) - Build #
5890 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/5890/
Java: 32bit/jdk1.8.0_92 -server -XX:+UseSerialGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.schema.TestManagedSchemaAPI
Error Message:
ObjectTracker found 8 object(s) that were not released!!! [MDCAwareThreadPoolExecutor, MockDirectoryWrapper, TransactionLog, TransactionLog, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 8 object(s) that were not released!!! [MDCAwareThreadPoolExecutor, MockDirectoryWrapper, TransactionLog, TransactionLog, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor]
at __randomizedtesting.SeedInfo.seed([94CB460BC30867F]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:256)
at sun.reflect.GeneratedMethodAccessor20.invoke(Unknown Source)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: junit.framework.TestSuite.org.apache.solr.schema.TestManagedSchemaAPI
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: java.nio.file.FileSystemException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: The process cannot access the file because it is being used by another process. C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: java.nio.file.FileSystemException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: The process cannot access the file because it is being used by another process.
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at __randomizedtesting.SeedInfo.seed([94CB460BC30867F:76D203E5D552ABF5]:0)
at org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1200)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:125)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:53)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 12086 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.overseer.ZkStateReaderTest_94CB460BC30867F-001\init-core-data-001
[junit4] 2> 2183814 INFO (SUITE-ZkStateReaderTest-seed#[94CB460BC30867F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2183816 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 2183818 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2183819 INFO (Thread-6292) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2183819 INFO (Thread-6292) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2183918 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:63431
[junit4] 2> 2183918 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2183920 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2183925 INFO (zkCallback-3217-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@474ffd name:ZooKeeperConnection Watcher:127.0.0.1:63431 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2183929 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2183930 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2183931 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f539710000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2183932 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2183933 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2183935 INFO (zkCallback-3218-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b3a9d3 name:ZooKeeperConnection Watcher:127.0.0.1:63431 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2183936 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2183936 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2183936 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2183938 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f539710001, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2183938 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2183941 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2183942 INFO (zkCallback-3219-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1088ec4 name:ZooKeeperConnection Watcher:127.0.0.1:63431/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2183943 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2183943 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2183943 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2183945 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2183946 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2183947 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2183950 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2183951 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2183952 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2183953 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2183956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 2183956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2183958 INFO (zkCallback-3219-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2183960 INFO (zkCallback-3219-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2183965 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2183965 INFO (zkCallback-3219-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 2183966 INFO (zkCallback-3219-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2183966 INFO (zkCallback-3219-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2183968 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f539710002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2183972 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63431 63431
[junit4] 2> 2183978 INFO (Thread-6292) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63431 63431
[junit4] 2> 2183981 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 2183986 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 2183987 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2183988 INFO (Thread-6293) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2183988 INFO (Thread-6293) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2184088 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:63509
[junit4] 2> 2184088 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2184089 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2184093 INFO (zkCallback-3221-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73bc4d name:ZooKeeperConnection Watcher:127.0.0.1:63509 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2184093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2184093 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2184094 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f53a1b0000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2184094 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2184097 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2184103 INFO (zkCallback-3222-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9bca3a name:ZooKeeperConnection Watcher:127.0.0.1:63509 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2184103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2184104 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2184104 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2184108 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f53a1b0001, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2184111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2184112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2184119 INFO (zkCallback-3223-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c3615c name:ZooKeeperConnection Watcher:127.0.0.1:63509/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2184119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2184119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2184124 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2184126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2184128 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2184131 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2184133 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2184136 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2184136 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2184139 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2184141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 2184141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2184143 INFO (zkCallback-3223-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2184146 INFO (zkCallback-3223-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2184148 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2184148 INFO (zkCallback-3223-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 2184150 INFO (zkCallback-3223-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2184150 INFO (zkCallback-3223-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214153 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f53a1b0002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214155 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63509 63509
[junit4] 2> 2214158 INFO (Thread-6293) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63509 63509
[junit4] 2> 2214161 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=94CB460BC30867F -Dtests.slow=true -Dtests.locale=zh-SG -Dtests.timezone=Africa/Ndjamena -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 30.2s J0 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
[junit4] > Throwable #1: java.util.concurrent.TimeoutException
[junit4] > at __randomizedtesting.SeedInfo.seed([94CB460BC30867F:76D203E5D552ABF5]:0)
[junit4] > at org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1200)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:125)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:53)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214166 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 2214167 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2214168 INFO (Thread-6294) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2214168 INFO (Thread-6294) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2214268 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:57610
[junit4] 2> 2214268 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214269 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214273 INFO (zkCallback-3225-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@18d984c name:ZooKeeperConnection Watcher:127.0.0.1:57610 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214273 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214274 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214275 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214278 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214280 INFO (zkCallback-3226-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@fdedc2 name:ZooKeeperConnection Watcher:127.0.0.1:57610 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214281 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214281 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214281 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2214285 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214286 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214288 INFO (zkCallback-3227-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19549ac name:ZooKeeperConnection Watcher:127.0.0.1:57610/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214288 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214288 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214289 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2214291 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2214293 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2214295 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2214296 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2214298 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2214299 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2214300 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2214303 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 2214303 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2214305 INFO (zkCallback-3227-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2214307 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2214308 INFO (zkCallback-3227-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214308 INFO (zkCallback-3227-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2214311 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57610 57610
[junit4] 2> 2214312 INFO (Thread-6294) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57610 57610
[junit4] 2> 2214316 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 2214319 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 2214321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2214321 INFO (Thread-6295) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2214321 INFO (Thread-6295) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2214421 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:57644
[junit4] 2> 2214421 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214422 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214427 INFO (zkCallback-3229-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@596a62 name:ZooKeeperConnection Watcher:127.0.0.1:57644 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214428 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214428 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214429 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f5b0970000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214430 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214431 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214433 INFO (zkCallback-3230-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1374de3 name:ZooKeeperConnection Watcher:127.0.0.1:57644 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214433 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214434 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214434 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2214438 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f5b0970001, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214438 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214439 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214442 INFO (zkCallback-3231-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@921ae3 name:ZooKeeperConnection Watcher:127.0.0.1:57644/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214442 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214442 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214442 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2214444 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2214445 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2214447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2214451 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2214453 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2214455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2214456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2214460 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2214461 INFO (zkCallback-3231-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2214465 INFO (zkCallback-3231-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214468 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 2214469 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2214469 INFO (zkCallback-3231-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 2214471 INFO (zkCallback-3231-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214472 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2214475 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57644 57644
[junit4] 2> 2214477 INFO (Thread-6295) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57644 57644
[junit4] 2> 2214479 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 2214484 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 2214486 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2214486 INFO (Thread-6296) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2214486 INFO (Thread-6296) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2214587 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:57660
[junit4] 2> 2214587 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214588 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214593 INFO (zkCallback-3233-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d981e7 name:ZooKeeperConnection Watcher:127.0.0.1:57660 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214593 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214593 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214594 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214596 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214597 INFO (zkCallback-3234-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a679fd name:ZooKeeperConnection Watcher:127.0.0.1:57660 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214597 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214597 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214598 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2214601 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214603 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214605 INFO (zkCallback-3235-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@90313e name:ZooKeeperConnection Watcher:127.0.0.1:57660/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214605 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214605 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214606 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2214608 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2214610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2214611 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2214613 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2214615 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2214615 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2214616 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2214618 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2214619 INFO (zkCallback-3235-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2214620 INFO (zkCallback-3235-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214621 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2214622 INFO (zkCallback-3235-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2214627 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57660 57660
[junit4] 2> 2214630 INFO (Thread-6296) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57660 57660
[junit4] 2> 2214632 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 2214637 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 2214638 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2214639 INFO (Thread-6297) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2214639 INFO (Thread-6297) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2214739 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer start zk server on port:57676
[junit4] 2> 2214739 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214740 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214746 INFO (zkCallback-3237-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6ddba1 name:ZooKeeperConnection Watcher:127.0.0.1:57676 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214746 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214747 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214751 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214751 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f5b1d50000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214752 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214754 INFO (zkCallback-3238-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ba8167 name:ZooKeeperConnection Watcher:127.0.0.1:57676 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214755 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214755 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214755 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2214760 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2214762 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2214764 INFO (zkCallback-3239-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a8b7f name:ZooKeeperConnection Watcher:127.0.0.1:57676/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2214765 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2214765 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2214765 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2214768 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2214770 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2214772 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2214774 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2214775 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2214776 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2214777 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2214779 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 2214781 INFO (zkCallback-3239-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 2214782 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 2214783 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 2214784 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f5b1d50002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2214787 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57676 57676
[junit4] 2> 2214791 INFO (Thread-6297) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57676 57676
[junit4] 2> 2214795 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[94CB460BC30867F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 2214796 INFO (SUITE-ZkStateReaderTest-seed#[94CB460BC30867F]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.overseer.ZkStateReaderTest_94CB460BC30867F-001
[junit4] 2> Jun 04, 2016 1:10:03 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62), sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=zh-SG, timezone=Africa/Ndjamena
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_92 (32-bit)/cpus=3,threads=1,free=277397136,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestFieldCacheSanityChecker, SparseHLLTest, HdfsUnloadDistributedZkTest, SliceStateTest, HdfsBasicDistributedZk2Test, BlockJoinFacetDistribTest, StatelessScriptUpdateProcessorFactoryTest, TestLMDirichletSimilarityFactory, UpdateParamsTest, TestArbitraryIndexDir, ZkCLITest, HdfsLockFactoryTest, TestCloudInspectUtil, PeerSyncTest, TestStressLucene, HighlighterMaxOffsetTest, DocumentBuilderTest, DocumentAnalysisRequestHandlerTest, TestSolrCloudWithKerberosAlt, TestRandomDVFaceting, DistributedQueryComponentCustomSortTest, TestIntervalFaceting, RequestLoggingTest, SpatialFilterTest, TestWordDelimiterFilterFactory, LeaderInitiatedRecoveryOnCommitTest, IndexSchemaTest, TermsComponentTest, TestSmileRequest, TestReplicationHandler, TestDocSet, HdfsCollectionsAPIDistributedZkTest, CustomCollectionTest, TestTestInjection, TestCollectionAPI, TestRawTransformer, RecoveryAfterSoftCommitTest, TestAddFieldRealTimeGet, ExplicitHLLTest, TestSweetSpotSimilarityFactory, TestSearchPerf, StandardRequestHandlerTest, ActionThrottleTest, DataDrivenBlockJoinTest, InfoHandlerTest, TestNumericTerms32, ScriptEngineTest, RegexBoostProcessorTest, TestBulkSchemaConcurrent, HdfsChaosMonkeyNothingIsSafeTest, TestRTimerTree, MBeansHandlerTest, HdfsRestartWhileUpdatingTest, TestFilteredDocIdSet, TestSearcherReuse, TestStressUserVersions, TestUninvertingReader, AnalyticsMergeStrategyTest, TestFieldCacheWithThreads, TestLeaderElectionZkExpiry, AlternateDirectoryTest, PrimUtilsTest, BlockJoinFacetSimpleTest, FastVectorHighlighterTest, TestConfigOverlay, SystemInfoHandlerTest, SampleTest, TestGroupingSearch, TestConfigSetProperties, TestScoreJoinQPNoScore, OverseerTest, SolrTestCaseJ4Test, SolrCoreTest, TestSha256AuthenticationProvider, TestFieldCollectionResource, TestCollationFieldDocValues, AsyncMigrateRouteKeyTest, SimpleCollectionCreateDeleteTest, TestSortingResponseWriter, HardAutoCommitTest, TestDistributedSearch, TestFaceting, TestBulkSchemaAPI, TestMiniSolrCloudClusterBase, TestSubQueryTransformer, SchemaVersionSpecificBehaviorTest, TestPerFieldSimilarityWithDefaultOverride, TestFunctionQuery, TestConfigSetsAPIExclusivity, TestDFRSimilarityFactory, DistributedExpandComponentTest, AtomicUpdatesTest, SolrRequestParserTest, TestRequestStatusCollectionAPI, HighlighterTest, TestSolrFieldCacheMBean, CircularListTest, TestNoOpRegenerator, HttpPartitionTest, TimeZoneUtilsTest, TestSurroundQueryParser, TestCSVLoader, SuggesterFSTTest, HLLSerializationTest, DisMaxRequestHandlerTest, DOMUtilTest, TestGraphMLResponseWriter, CurrencyFieldXmlFileTest, TestMergePolicyConfig, WrapperMergePolicyFactoryTest, TestComponentsName, TestSolrDeletionPolicy1, TestTrackingShardHandlerFactory, TestLazyCores, TestXIncludeConfig, TestConfigReload, OverseerCollectionConfigSetProcessorTest, TestSolrQueryParserResource, TestElisionMultitermQuery, TestSolrDynamicMBean, TestSubQueryTransformerDistrib, TestDFISimilarityFactory, TestTolerantUpdateProcessorRandomCloud, JsonLoaderTest, TestCustomDocTransformer, TestDynamicLoading, TestPostingsSolrHighlighter, TestMinMaxOnMultiValuedField, TestFieldTypeCollectionResource, ZkControllerTest, DistributedSuggestComponentTest, DistribCursorPagingTest, ReplicationFactorTest, DeleteShardTest, TestFieldCacheSortRandom, TestJmxIntegration, ReturnFieldsTest, IndexBasedSpellCheckerTest, MigrateRouteKeyTest, HdfsRecoverLeaseTest, SuggestComponentTest, ClusterStateUpdateTest, TestJsonRequest, OverseerStatusTest, TestPhraseSuggestions, DeleteLastCustomShardedReplicaTest, TestReqParamsAPI, DistributedFacetPivotLongTailTest, DocValuesMultiTest, BasicDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, TestRandomFaceting, LeaderElectionTest, TestRecovery, DistributedSpellCheckComponentTest, TestRealTimeGet, TestStressReorder, TestReload, TestRangeQuery, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, QueryElevationComponentTest, ConvertedLegacyTest, TestSort, TestFiltering, TestBadConfig, CurrencyFieldOpenExchangeTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterWFSTTest, PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, TestRemoteStreaming, XsltUpdateRequestHandlerTest, TestWriterPerf, TestQueryTypes, TestOmitPositions, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest, TestCollationField, JSONWriterTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, TestLFUCache, CopyFieldTest, SolrIndexConfigTest, NumericFieldsTest, TestConfig, TestSolrCoreProperties, TestLuceneMatchVersion, TestCodecSupport, TestJmxMonitoredMap, PluginInfoTest, TestFastLRUCache, DateMathParserTest, ChaosMonkeyNothingIsSafeTest, TestEmbeddedSolrServerConstructors, AliasIntegrationTest, CleanupOldIndexTest, CollectionStateFormat2Test, CollectionTooManyReplicasTest, DeleteStatusTest, DistribJoinFromCollectionTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerRolesTest, RestartWhileUpdatingTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudBackupRestore, TestCloudDeleteByQuery, TestCryptoKeys, TestDistribDocBasedVersion, TestDownShardTolerantSearch, TestLeaderInitiatedRecoveryThread, TestRandomRequestDistribution, TestReplicaProperties, TestStressCloudBlindAtomicUpdates, TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest, HdfsThreadLeakTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, ZkStateReaderTest]
[junit4] Completed [495/612 (1!)] on J0 in 32.03s, 6 tests, 1 error <<< FAILURES!
[...truncated 163 lines...]
[junit4] Suite: org.apache.solr.schema.TestManagedSchemaAPI
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\init-core-data-001
[junit4] 2> 2392230 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2392232 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2392248 INFO (Thread-7498) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2392248 INFO (Thread-7498) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2392333 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:59324
[junit4] 2> 2392333 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2392334 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392338 INFO (zkCallback-4088-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@181ba91 name:ZooKeeperConnection Watcher:127.0.0.1:59324 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392338 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392339 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2392339 INFO (SUITE-TestManagedSchemaAPI-seed#[94CB460BC30867F]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 2392345 INFO (jetty-launcher-4087-thread-1) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2392346 INFO (jetty-launcher-4087-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@f3522d{/solr,null,AVAILABLE}
[junit4] 2> 2392347 INFO (jetty-launcher-4087-thread-2) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@fee4d5{HTTP/1.1,[http/1.1]}{127.0.0.1:59328}
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.e.j.s.Server Started @2401584ms
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59328}
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@70db01{/solr,null,AVAILABLE}
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node2'
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2392348 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.e.j.s.ServerConnector Started ServerConnector@98bd5a{HTTP/1.1,[http/1.1]}{127.0.0.1:59331}
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.e.j.s.Server Started @2401585ms
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59331}
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1'
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2392349 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2392350 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392350 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2392351 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392382 INFO (zkCallback-4090-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@76bd0c name:ZooKeeperConnection Watcher:127.0.0.1:59324/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392383 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392383 INFO (zkCallback-4089-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1987a8a name:ZooKeeperConnection Watcher:127.0.0.1:59324/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392383 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392383 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2392383 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2392384 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2392384 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2392399 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\.
[junit4] 2> 2392400 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.CoreContainer New CoreContainer 21008821
[junit4] 2> 2392400 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1]
[junit4] 2> 2392400 WARN (jetty-launcher-4087-thread-2) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\lib
[junit4] 2> 2392400 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 2392405 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
[junit4] 2> 2392407 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2392408 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2392408 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59324/solr
[junit4] 2> 2392408 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 2392408 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2392409 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392425 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node2\.
[junit4] 2> 2392425 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 7511176
[junit4] 2> 2392425 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node2]
[junit4] 2> 2392425 WARN (jetty-launcher-4087-thread-1) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node2\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node2\lib
[junit4] 2> 2392426 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 2392428 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
[junit4] 2> 2392428 INFO (zkCallback-4093-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ea067f name:ZooKeeperConnection Watcher:127.0.0.1:59324 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392429 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392429 INFO (jetty-launcher-4087-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2392430 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2392430 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2392430 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59324/solr
[junit4] 2> 2392430 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 2392430 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2392430 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15518f867a10003, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2392431 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$12/17411291@5e254a
[junit4] 2> 2392433 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392433 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392435 INFO (zkCallback-4096-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@13f5286 name:ZooKeeperConnection Watcher:127.0.0.1:59324 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392435 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392435 INFO (zkCallback-4097-thread-1-processing-n:127.0.0.1:59331_solr) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@71a91e name:ZooKeeperConnection Watcher:127.0.0.1:59324/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392435 INFO (jetty-launcher-4087-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2392435 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392436 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2392438 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$12/17411291@1f6a1de
[junit4] 2> 2392439 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2392449 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 2392474 INFO (zkCallback-4098-thread-1-processing-n:127.0.0.1:59328_solr) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@129cb33 name:ZooKeeperConnection Watcher:127.0.0.1:59324/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2392474 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2392476 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 2392477 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 2392479 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 2392481 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2392481 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2392482 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2392483 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2392484 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2392485 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2392485 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2392486 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2392494 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2392508 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2392513 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2392520 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2392521 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2392522 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2392522 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2392524 INFO (jetty-launcher-4087-thread-2) [n:127.0.0.1:59331_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2392525 INFO (jetty-launcher-4087-thread-1) [n:127.0.0.1:59328_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2392526 INFO
[...truncated too long message...]
dCollectionResource, TestCollationFieldDocValues, AsyncMigrateRouteKeyTest, SimpleCollectionCreateDeleteTest, TestSortingResponseWriter, HardAutoCommitTest, TestDistributedSearch, TestFaceting, TestBulkSchemaAPI, TestMiniSolrCloudClusterBase, TestSubQueryTransformer, SchemaVersionSpecificBehaviorTest, TestPerFieldSimilarityWithDefaultOverride, TestFunctionQuery, TestConfigSetsAPIExclusivity, TestDFRSimilarityFactory, DistributedExpandComponentTest, AtomicUpdatesTest, SolrRequestParserTest, TestRequestStatusCollectionAPI, HighlighterTest, TestSolrFieldCacheMBean, CircularListTest, TestNoOpRegenerator, HttpPartitionTest, TimeZoneUtilsTest, TestSurroundQueryParser, TestCSVLoader, SuggesterFSTTest, HLLSerializationTest, DisMaxRequestHandlerTest, DOMUtilTest, TestGraphMLResponseWriter, CurrencyFieldXmlFileTest, TestMergePolicyConfig, WrapperMergePolicyFactoryTest, TestComponentsName, TestSolrDeletionPolicy1, TestTrackingShardHandlerFactory, TestLazyCores, TestXIncludeConfig, TestConfigReload, OverseerCollectionConfigSetProcessorTest, TestSolrQueryParserResource, TestElisionMultitermQuery, TestSolrDynamicMBean, TestSubQueryTransformerDistrib, TestDFISimilarityFactory, TestTolerantUpdateProcessorRandomCloud, JsonLoaderTest, TestCustomDocTransformer, TestDynamicLoading, TestPostingsSolrHighlighter, TestMinMaxOnMultiValuedField, TestFieldTypeCollectionResource, ZkControllerTest, DistributedSuggestComponentTest, DistribCursorPagingTest, ReplicationFactorTest, DeleteShardTest, TestFieldCacheSortRandom, TestJmxIntegration, ReturnFieldsTest, IndexBasedSpellCheckerTest, MigrateRouteKeyTest, HdfsRecoverLeaseTest, SuggestComponentTest, ClusterStateUpdateTest, TestJsonRequest, OverseerStatusTest, TestPhraseSuggestions, DeleteLastCustomShardedReplicaTest, TestReqParamsAPI, DistributedFacetPivotLongTailTest, DocValuesMultiTest, BasicDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, TestRandomFaceting, LeaderElectionTest, TestRecovery, DistributedSpellCheckComponentTest, TestRealTimeGet, TestStressReorder, TestReload, TestRangeQuery, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, QueryElevationComponentTest, ConvertedLegacyTest, TestSort, TestFiltering, TestBadConfig, CurrencyFieldOpenExchangeTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterWFSTTest, PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, TestRemoteStreaming, XsltUpdateRequestHandlerTest, TestWriterPerf, TestQueryTypes, TestOmitPositions, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest, TestCollationField, JSONWriterTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, TestLFUCache, CopyFieldTest, SolrIndexConfigTest, NumericFieldsTest, TestConfig, TestSolrCoreProperties, TestLuceneMatchVersion, TestCodecSupport, TestJmxMonitoredMap, PluginInfoTest, TestFastLRUCache, DateMathParserTest, ChaosMonkeyNothingIsSafeTest, TestEmbeddedSolrServerConstructors, AliasIntegrationTest, CleanupOldIndexTest, CollectionStateFormat2Test, CollectionTooManyReplicasTest, DeleteStatusTest, DistribJoinFromCollectionTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerRolesTest, RestartWhileUpdatingTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudBackupRestore, TestCloudDeleteByQuery, TestCryptoKeys, TestDistribDocBasedVersion, TestDownShardTolerantSearch, TestLeaderInitiatedRecoveryThread, TestRandomRequestDistribution, TestReplicaProperties, TestStressCloudBlindAtomicUpdates, TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest, HdfsThreadLeakTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, ZkStateReaderTest, BlobRepositoryCloudTest, CachingDirectoryFactoryTest, DirectoryFactoryTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, TestInfoStreamLogging, TestInitParams, TestNRTOpen, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrXml, TestSQLHandler, TestSolrConfigHandlerCloud, CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, SegmentsInfoRequestHandlerTest, DistributedDebugComponentTest, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallTest, SpatialHeatmapFacetsTest, TestManagedSchema, TestManagedSchemaAPI]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestManagedSchemaAPI -Dtests.seed=94CB460BC30867F -Dtests.slow=true -Dtests.locale=ja-JP -Dtests.timezone=Europe/Helsinki -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J0 | TestManagedSchemaAPI (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 8 object(s) that were not released!!! [MDCAwareThreadPoolExecutor, MockDirectoryWrapper, TransactionLog, TransactionLog, MockDirectoryWrapper, MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor]
[junit4] > at __randomizedtesting.SeedInfo.seed([94CB460BC30867F]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:256)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: java.nio.file.FileSystemException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog\tlog.0000000000000000000: The process cannot access the file because it is being used by another process.
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data\tlog
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1\data
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1\testschemaapi_shard1_replica1
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001\node1
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001\tempDir-001
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestManagedSchemaAPI_94CB460BC30867F-001
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [549/612 (2!)] on J0 in 13.64s, 1 test, 1 failure, 1 error <<< FAILURES!
[...truncated 217 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:740: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:684: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\common-build.xml:531: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1427: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:984: There were test failures: 612 suites (10 ignored), 2560 tests, 2 suite-level errors, 1 error, 126 ignored (82 assumptions) [seed: 94CB460BC30867F]
Total time: 64 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any