Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4329/ Java: 64bit/jdk1.8.0_40-ea-b04 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed. REGRESSION: org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[https://127.0.0.1:52017, https://127.0.0.1:52041, https://127.0.0.1:52032] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:52017, https://127.0.0.1:52041, https://127.0.0.1:52032] at __randomizedtesting.SeedInfo.seed([DECDA0BC7458AF0F:5F2B2EA40307CF33]:0) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322) at org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:878) at org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658) at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601) at org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest.removeAndWaitForLastReplicaGone(DeleteLastCustomShardedReplicaTest.java:117) at org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest.doTest(DeleteLastCustomShardedReplicaTest.java:107) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not remove replica : customcollreplicadeletion/a/core_node2 at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304) ... 45 more FAILED: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[https://127.0.0.1:56247, https://127.0.0.1:56271, https://127.0.0.1:56280, https://127.0.0.1:56262, https://127.0.0.1:56289] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:56247, https://127.0.0.1:56271, https://127.0.0.1:56280, https://127.0.0.1:56262, https://127.0.0.1:56289] at __randomizedtesting.SeedInfo.seed([DECDA0BC7458AF0F:5F2B2EA40307CF33]:0) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:322) at org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:878) at org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:658) at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:601) at org.apache.solr.cloud.DeleteReplicaTest.removeAndWaitForReplicaGone(DeleteReplicaTest.java:171) at org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:144) at org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:88) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not remove replica : delLiveColl/shard1/core_node1 at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:343) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:304) ... 46 more Build Log: [...truncated 11209 lines...] [junit4] Suite: org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\init-core-data-001 [junit4] 2> 2283321 T6136 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 2283321 T6136 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 2283324 T6136 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 2283325 T6136 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2283326 T6137 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 2283422 T6136 oasc.ZkTestServer.run start zk server on port:52007 [junit4] 2> 2283422 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2283425 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2283433 T6143 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@30d4aa77 name:ZooKeeperConnection Watcher:127.0.0.1:52007 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2283433 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2283433 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2283433 T6136 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 2283440 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2283441 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2283445 T6145 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6f6171de name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2283445 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2283445 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2283445 T6136 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 2283449 T6136 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 2283453 T6136 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 2283456 T6136 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 2283459 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2283460 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 2283465 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml [junit4] 2> 2283465 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 2283471 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2283471 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2283476 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2283476 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 2283481 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2283481 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 2283486 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 2283487 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 2283491 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2283491 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 2283498 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2283498 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 2283504 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2283504 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2283509 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2283510 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 2283515 T6136 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2283515 T6136 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 2283522 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2283522 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2283525 T6147 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2b686266 name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2283526 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2283526 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2285298 T6136 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2285309 T6136 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2285311 T6136 oejs.AbstractConnector.doStart Started [email protected]:52017 [junit4] 2> 2285316 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 2285317 T6136 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2285318 T6136 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002 [junit4] 2> 2285318 T6136 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\' [junit4] 2> 2285351 T6136 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\solr.xml [junit4] 2> 2285364 T6136 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002 [junit4] 2> 2285364 T6136 oasc.CoreContainer.<init> New CoreContainer 2113561788 [junit4] 2> 2285365 T6136 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\] [junit4] 2> 2285365 T6136 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2285366 T6136 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2285366 T6136 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2285366 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2285367 T6136 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2285367 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2285367 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2285368 T6136 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2285368 T6136 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2285371 T6136 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 2285374 T6136 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2285374 T6136 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2285375 T6136 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2285375 T6136 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:52007/solr [junit4] 2> 2285376 T6136 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2285376 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2285378 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2285381 T6158 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@25fd2d53 name:ZooKeeperConnection Watcher:127.0.0.1:52007 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2285382 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2285382 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2285386 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2285388 T6160 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@722c105 name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2285389 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2285391 T6136 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 2285398 T6136 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 2285401 T6136 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 2285408 T6136 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 2285415 T6136 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 2285419 T6136 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 2285421 T6136 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52017_ [junit4] 2> 2285422 T6136 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52017_ [junit4] 2> 2285427 T6136 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 2285430 T6136 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 2285432 T6136 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2285435 T6136 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:52017_ [junit4] 2> 2285435 T6136 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 2285438 T6136 oasc.Overseer.start Overseer (id=92491045186699268-127.0.0.1:52017_-n_0000000000) starting [junit4] 2> 2285441 T6136 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 2285453 T6136 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2285454 T6162 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 2285456 T6136 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 2285459 T6136 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 2285461 T6136 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2285467 T6161 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 2285467 T6136 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002 [junit4] 2> 2286618 T6136 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\conf\ [junit4] 2> 2286787 T6136 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2286789 T6136 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2286789 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2286803 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2286805 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2286807 T6166 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64554e80 name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2286807 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2286807 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2286810 T6136 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2286816 T6136 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 2286817 T6136 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2 [junit4] 2> 2286817 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2286818 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2286819 T6168 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6819d6f9 name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2286820 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2286820 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2286823 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2286824 T6138 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x148981d95420006, 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> [junit4] 2> 2286830 T6161 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: collection1 [junit4] 2> 2286830 T6161 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2] [junit4] 2> 2286830 T6161 oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2 [junit4] 2> 2286838 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/collection1/state.json [junit4] 2> 2286842 T6169 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2286849 T6170 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2288563 T6136 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 2288564 T6136 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2288573 T6136 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2288576 T6136 oejs.AbstractConnector.doStart Started [email protected]:52032 [junit4] 2> 2288583 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 2288583 T6136 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2288583 T6136 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003 [junit4] 2> 2288583 T6136 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003\' [junit4] 2> 2288615 T6136 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003\solr.xml [junit4] 2> 2288624 T6136 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003 [junit4] 2> 2288626 T6136 oasc.CoreContainer.<init> New CoreContainer 1268201598 [junit4] 2> 2288626 T6136 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003\] [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2288628 T6136 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2288631 T6136 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 2288635 T6136 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2288635 T6136 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2288635 T6136 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2288635 T6136 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:52007/solr [junit4] 2> 2288635 T6136 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2288635 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2288639 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2288640 T6181 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2545edeb name:ZooKeeperConnection Watcher:127.0.0.1:52007 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2288641 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2288641 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2288644 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2288646 T6183 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7a8ab10b name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2288646 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2288657 T6136 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2289626 T6136 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52032_ [junit4] 2> 2289628 T6136 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52032_ [junit4] 2> 2289635 T6136 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2289641 T6136 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003 [junit4] 2> 2290783 T6136 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-003\conf\ [junit4] 2> 2290977 T6136 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2290978 T6136 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2290979 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2292672 T6136 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 2292672 T6136 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2292681 T6136 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2292685 T6136 oejs.AbstractConnector.doStart Started [email protected]:52041 [junit4] 2> 2292687 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 2292687 T6136 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2292688 T6136 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004 [junit4] 2> 2292688 T6136 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\' [junit4] 2> 2292735 T6136 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\solr.xml [junit4] 2> 2292748 T6136 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004 [junit4] 2> 2292749 T6136 oasc.CoreContainer.<init> New CoreContainer 260033196 [junit4] 2> 2292749 T6136 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\] [junit4] 2> 2292750 T6136 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2292750 T6136 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2292750 T6136 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2292750 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2292751 T6136 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2292751 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2292751 T6136 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2292752 T6136 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2292752 T6136 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2292756 T6136 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 2292758 T6136 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2292758 T6136 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2292758 T6136 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2292759 T6136 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:52007/solr [junit4] 2> 2292759 T6136 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2292759 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2292761 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2292763 T6196 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@46ee347c name:ZooKeeperConnection Watcher:127.0.0.1:52007 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2292763 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2292763 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2292767 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2292768 T6198 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3206db6a name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2292769 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2292782 T6136 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2293654 T6136 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52041_ [junit4] 2> 2293657 T6136 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:52041_ [junit4] 2> 2293672 T6136 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2293677 T6136 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004 [junit4] 2> 2294273 T6136 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\conf\ [junit4] 2> 2294373 T6136 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2294375 T6136 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2294375 T6136 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2294384 T6136 oasc.AbstractFullDistribZkTestBase.createCollection Creating collection with stateFormat=2: customcollreplicadeletion [junit4] 2> 2294384 T6136 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2294388 T6136 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2294390 T6202 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@28aeb844 name:ZooKeeperConnection Watcher:127.0.0.1:52007/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2294390 T6136 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2294390 T6136 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2294392 T6136 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2294434 T6153 oasha.CollectionsHandler.handleCreateAction Creating Collection : replicationFactor=1&shards=a,b&maxShardsPerNode=5&router.name=implicit&name=customcollreplicadeletion&action=CREATE&numShards=1&stateFormat=2&wt=javabin&version=2 [junit4] 2> 2294436 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged [junit4] 2> 2294439 T6162 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{ [junit4] 2> "operation":"create", [junit4] 2> "fromApi":"true", [junit4] 2> "name":"customcollreplicadeletion", [junit4] 2> "replicationFactor":"1", [junit4] 2> "numShards":"1", [junit4] 2> "maxShardsPerNode":"5", [junit4] 2> "shards":"a,b", [junit4] 2> "stateFormat":"2", [junit4] 2> "router.name":"implicit"} [junit4] 2> 2294441 T6203 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : create , { [junit4] 2> "operation":"create", [junit4] 2> "fromApi":"true", [junit4] 2> "name":"customcollreplicadeletion", [junit4] 2> "replicationFactor":"1", [junit4] 2> "numShards":"1", [junit4] 2> "maxShardsPerNode":"5", [junit4] 2> "shards":"a,b", [junit4] 2> "stateFormat":"2", [junit4] 2> "router.name":"implicit"} [junit4] 2> 2294444 T6203 oasc.OverseerCollectionProcessor.createConfNode Only one config set found in zk - using it:conf1 [junit4] 2> 2294444 T6203 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/customcollreplicadeletion [junit4] 2> 2294446 T6203 oascc.SolrZkClient.makePath makePath: /collections/customcollreplicadeletion [junit4] 2> 2294453 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2294462 T6161 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: customcollreplicadeletion [junit4] 2> 2294462 T6161 oasc.Overseer$ClusterStateUpdater.createCollection Create collection customcollreplicadeletion with shards [a, b] [junit4] 2> 2294463 T6161 oasc.Overseer$ClusterStateUpdater.createCollection state version customcollreplicadeletion 2 [junit4] 2> 2294469 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2294471 T6169 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 2294472 T6184 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 2294472 T6199 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 2294473 T6170 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 2294474 T6204 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 2294540 T6203 oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new collection customcollreplicadeletion, shardNames [a, b] , replicationFactor : 1 [junit4] 2> 2294540 T6203 oasc.OverseerCollectionProcessor.createCollection Creating shard customcollreplicadeletion_a_replica1 as part of slice a of collection customcollreplicadeletion on 127.0.0.1:52017_ [junit4] 2> 2294543 T6203 oasc.OverseerCollectionProcessor.createCollection Creating shard customcollreplicadeletion_b_replica1 as part of slice b of collection customcollreplicadeletion on 127.0.0.1:52041_ [junit4] 2> 2294579 T6193 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=customcollreplicadeletion_b_replica1&action=CREATE&numShards=2&collection=customcollreplicadeletion&shard=b&wt=javabin&version=2 [junit4] 2> 2294580 T6154 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=customcollreplicadeletion_a_replica1&action=CREATE&numShards=2&collection=customcollreplicadeletion&shard=a&wt=javabin&version=2 [junit4] 2> 2294589 T6193 oasc.ZkController.publish publishing core=customcollreplicadeletion_b_replica1 state=down collection=customcollreplicadeletion [junit4] 2> 2294590 T6154 oasc.ZkController.publish publishing core=customcollreplicadeletion_a_replica1 state=down collection=customcollreplicadeletion [junit4] 2> 2294593 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2294596 T6193 oasc.ZkController.preRegister Registering watch for external collection customcollreplicadeletion [junit4] 2> 2294596 T6193 oascc.ZkStateReader.addZkWatch addZkWatch customcollreplicadeletion [junit4] 2> 2294598 T6193 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/customcollreplicadeletion/state.json from ZooKeeper... [junit4] 2> 2294599 T6154 oasc.ZkController.preRegister Registering watch for external collection customcollreplicadeletion [junit4] 2> 2294602 T6193 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 0 [junit4] 2> 2294603 T6193 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2294603 T6161 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"customcollreplicadeletion_b_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:52041";, [junit4] 2> "node_name":"127.0.0.1:52041_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"b", [junit4] 2> "collection":"customcollreplicadeletion", [junit4] 2> "operation":"state"} [junit4] 2> 2294619 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2294620 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2294621 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 1 [junit4] 2> 2294623 T6154 oascc.ZkStateReader.addZkWatch addZkWatch customcollreplicadeletion [junit4] 2> 2294624 T6154 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/customcollreplicadeletion/state.json from ZooKeeper... [junit4] 2> 2294628 T6154 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 1 [junit4] 2> 2294628 T6154 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2294636 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 1 [junit4] 2> 2294637 T6161 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"customcollreplicadeletion_a_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:52017";, [junit4] 2> "node_name":"127.0.0.1:52017_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"a", [junit4] 2> "collection":"customcollreplicadeletion", [junit4] 2> "operation":"state"} [junit4] 2> 2294641 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2294642 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2294643 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2294644 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2294645 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 2 [junit4] 2> 2294649 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 2 [junit4] 2> 2295468 T6193 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for customcollreplicadeletion_b_replica1 [junit4] 2> 2295468 T6193 oasc.ZkController.createCollectionZkNode Check for collection zkNode:customcollreplicadeletion [junit4] 2> 2295469 T6193 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2295469 T6193 oascc.ZkStateReader.readConfigName Load collection config from:/collections/customcollreplicadeletion [junit4] 2> 2295471 T6193 oascc.ZkStateReader.readConfigName path=/collections/customcollreplicadeletion configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2295471 T6193 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\' [junit4] 2> 2295493 T6154 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for customcollreplicadeletion_a_replica1 [junit4] 2> 2295493 T6154 oasc.ZkController.createCollectionZkNode Check for collection zkNode:customcollreplicadeletion [junit4] 2> 2295495 T6154 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2295495 T6154 oascc.ZkStateReader.readConfigName Load collection config from:/collections/customcollreplicadeletion [junit4] 2> 2295497 T6154 oascc.ZkStateReader.readConfigName path=/collections/customcollreplicadeletion configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2295497 T6154 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\' [junit4] 2> 2295534 T6193 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 2295546 T6154 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 2295551 T6193 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2295556 T6193 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2295556 T6154 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2295559 T6154 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2295562 T6193 oass.IndexSchema.readSchema [customcollreplicadeletion_b_replica1] Schema name=test [junit4] 2> 2295572 T6154 oass.IndexSchema.readSchema [customcollreplicadeletion_a_replica1] Schema name=test [junit4] 2> 2295701 T6154 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2295701 T6193 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2295707 T6154 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2295707 T6193 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2295707 T6154 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2295707 T6193 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2295724 T6193 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2295729 T6154 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2295729 T6193 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2295737 T6193 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2295738 T6154 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2295740 T6193 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2295741 T6193 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2295741 T6193 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2295743 T6154 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2295743 T6193 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2295744 T6193 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2295744 T6193 oasc.CoreContainer.create Creating SolrCore 'customcollreplicadeletion_b_replica1' using configuration from collection customcollreplicadeletion [junit4] 2> 2295744 T6193 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2295745 T6193 oasc.SolrCore.<init> [customcollreplicadeletion_b_replica1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\data\ [junit4] 2> 2295745 T6193 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@af08f62 [junit4] 2> 2295745 T6154 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2295745 T6154 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2295745 T6193 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\data\ [junit4] 2> 2295746 T6193 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\data\index/ [junit4] 2> 2295745 T6154 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2295746 T6193 oasc.SolrCore.initIndex WARN [customcollreplicadeletion_b_replica1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\data\index' doesn't exist. Creating new index... [junit4] 2> 2295747 T6193 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-004\customcollreplicadeletion_b_replica1\data\index [junit4] 2> 2295748 T6154 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2295749 T6154 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2295748 T6193 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=52.1923828125, floorSegmentMB=0.6279296875, forceMergeDeletesPctAllowed=17.450719724015507, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21261664351234996 [junit4] 2> 2295749 T6154 oasc.CoreContainer.create Creating SolrCore 'customcollreplicadeletion_a_replica1' using configuration from collection customcollreplicadeletion [junit4] 2> 2295750 T6154 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2295750 T6193 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-6675a951)),segFN=segments_1,generation=1} [junit4] 2> 2295751 T6193 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2295750 T6154 oasc.SolrCore.<init> [customcollreplicadeletion_a_replica1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\data\ [junit4] 2> 2295751 T6154 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@af08f62 [junit4] 2> 2295752 T6154 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\data\ [junit4] 2> 2295752 T6154 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\data\index/ [junit4] 2> 2295752 T6154 oasc.SolrCore.initIndex WARN [customcollreplicadeletion_a_replica1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\data\index' doesn't exist. Creating new index... [junit4] 2> 2295753 T6154 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteLastCustomShardedReplicaTest-DECDA0BC7458AF0F-001\tempDir-002\customcollreplicadeletion_a_replica1\data\index [junit4] 2> 2295753 T6154 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=52.1923828125, floorSegmentMB=0.6279296875, forceMergeDeletesPctAllowed=17.450719724015507, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21261664351234996 [junit4] 2> 2295753 T6193 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2295754 T6154 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-7a845fa0)),segFN=segments_1,generation=1} [junit4] 2> 2295754 T6193 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2295755 T6154 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2295755 T6193 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2295756 T6193 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2295756 T6193 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2295756 T6193 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2295756 T6193 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2295756 T6193 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2295757 T6193 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2295757 T6154 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2295757 T6193 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295758 T6154 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2295758 T6193 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295758 T6154 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2295759 T6193 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295759 T6154 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2295760 T6193 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 2295760 T6154 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2295761 T6193 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 2295761 T6154 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2295762 T6193 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 2295762 T6154 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2295762 T6154 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2295762 T6154 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2295762 T6193 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 2295763 T6154 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295763 T6154 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295763 T6193 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 2295764 T6154 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2295764 T6193 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 2295764 T6154 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 2295765 T6193 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 2295765 T6154 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 2295766 T6193 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 2295766 T6154 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 2295767 T6154 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 2295767 T6154 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 2295767 T6154 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 2295767 T6154 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 2295768 T6154 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 2295770 T6154 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295772 T6154 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295773 T6154 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295775 T6154 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295778 T6154 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2295778 T6154 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2295779 T6154 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=54.609375, floorSegmentMB=1.1572265625, forceMergeDeletesPctAllowed=5.007696972959474, segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.40778704882263994 [junit4] 2> 2295780 T6154 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-7a845fa0)),segFN=segments_1,generation=1} [junit4] 2> 2295780 T6154 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2295781 T6154 oass.SolrIndexSearcher.<init> Opening Searcher@72c4d992[customcollreplicadeletion_a_replica1] main [junit4] 2> 2295781 T6154 oascc.ZkStateReader.readConfigName Load collection config from:/collections/customcollreplicadeletion [junit4] 2> 2295782 T6193 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295783 T6193 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295785 T6193 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295786 T6193 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2295789 T6193 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2295789 T6193 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2295791 T6193 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=54.609375, floorSegmentMB=1.1572265625, forceMergeDeletesPctAllowed=5.007696972959474, segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.40778704882263994 [junit4] 2> 2295791 T6193 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-6675a951)),segFN=segments_1,generation=1} [junit4] 2> 2295791 T6193 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2295792 T6193 oass.SolrIndexSearcher.<init> Opening Searcher@6bc6d2d8[customcollreplicadeletion_b_replica1] main [junit4] 2> 2295792 T6193 oascc.ZkStateReader.readConfigName Load collection config from:/collections/customcollreplicadeletion [junit4] 2> 2295794 T6154 oascc.ZkStateReader.readConfigName path=/collections/customcollreplicadeletion configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2295794 T6154 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 2295794 T6154 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2295794 T6154 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 2295794 T6154 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295796 T6193 oascc.ZkStateReader.readConfigName path=/collections/customcollreplicadeletion configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2295796 T6193 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 2295797 T6154 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 2295797 T6154 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295798 T6193 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2295798 T6193 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 2295798 T6193 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295799 T6154 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 2295800 T6193 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 2295800 T6193 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295804 T6193 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 2295805 T6154 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295805 T6154 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2295806 T6193 oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new znode /configs/conf1/_rest_managed.json [junit4] 2> 2295806 T6193 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2295807 T6193 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2295812 T6154 oasc.CoreContainer.registerCore registering core: customcollreplicadeletion_a_replica1 [junit4] 2> 2295813 T6154 oasc.ZkController.register Register replica - core:customcollreplicadeletion_a_replica1 address:https://127.0.0.1:52017 collection:customcollreplicadeletion shard:a [junit4] 2> 2295814 T6207 oasc.SolrCore.registerSearcher [customcollreplicadeletion_a_replica1] Registered new searcher Searcher@72c4d992[customcollreplicadeletion_a_replica1] main{UninvertingDirectoryReader()} [junit4] 2> 2295812 T6193 oasc.CoreContainer.registerCore registering core: customcollreplicadeletion_b_replica1 [junit4] 2> 2295815 T6193 oasc.ZkController.register Register replica - core:customcollreplicadeletion_b_replica1 address:https://127.0.0.1:52041 collection:customcollreplicadeletion shard:b [junit4] 2> 2295813 T6208 oasc.SolrCore.registerSearcher [customcollreplicadeletion_b_replica1] Registered new searcher Searcher@6bc6d2d8[customcollreplicadeletion_b_replica1] main{UninvertingDirectoryReader()} [junit4] 2> 2295819 T6154 oascc.SolrZkClient.makePath makePath: /collections/customcollreplicadeletion/leader_elect/a/election [junit4] 2> 2295820 T6193 oascc.SolrZkClient.makePath makePath: /collections/customcollreplicadeletion/leader_elect/b/election [junit4] 2> 2295831 T6154 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard a [junit4] 2> 2295832 T6193 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard b [junit4] 2> 2295833 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2295835 T6193 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 2295836 T6193 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C4755 name=customcollreplicadeletion_b_replica1 org.apache.solr.core.SolrCore@15d318b8 url=https://127.0.0.1:52041/customcollreplicadeletion_b_replica1 node=127.0.0.1:52041_ C4755_STATE=coll:customcollreplicadeletion core:customcollreplicadeletion_b_replica1 props:{core=customcollreplicadeletion_b_replica1, base_url=https://127.0.0.1:52041, node_name=127.0.0.1:52041_, state=down} [junit4] 2> 2295836 T6193 C4755 P52041 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:52041/customcollreplicadeletion_b_replica1/ [junit4] 2> 2295837 T6193 C4755 P52041 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 2295837 T6193 C4755 P52041 oasc.SyncStrategy.syncToMe https://127.0.0.1:52041/customcollreplicadeletion_b_replica1/ has no replicas [junit4] 2> 2295836 T6154 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 2295837 T6154 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C4756 name=customcollreplicadeletion_a_replica1 org.apache.solr.core.SolrCore@7c42dc3d url=https://127.0.0.1:52017/customcollreplicadeletion_a_replica1 node=127.0.0.1:52017_ C4756_STATE=coll:customcollreplicadeletion core:customcollreplicadeletion_a_replica1 props:{core=customcollreplicadeletion_a_replica1, base_url=https://127.0.0.1:52017, node_name=127.0.0.1:52017_, state=down} [junit4] 2> 2295837 T6154 C4756 P52017 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:52017/customcollreplicadeletion_a_replica1/ [junit4] 2> 2295838 T6154 C4756 P52017 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 2295838 T6154 C4756 P52017 oasc.SyncStrategy.syncToMe https://127.0.0.1:52017/customcollreplicadeletion_a_replica1/ has no replicas [junit4] 2> 2295838 T6154 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:52017/customcollreplicadeletion_a_replica1/ a [junit4] 2> 2295839 T6154 oascc.SolrZkClient.makePath makePath: /collections/customcollreplicadeletion/leaders/a [junit4] 2> 2295837 T6193 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:52041/customcollreplicadeletion_b_replica1/ b [junit4] 2> 2295840 T6193 oascc.SolrZkClient.makePath makePath: /collections/customcollreplicadeletion/leaders/b [junit4] 2> 2295843 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 2 [junit4] 2> 2295849 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2295851 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295852 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295852 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 3 [junit4] 2> 2295856 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 3 [junit4] 2> 2295861 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 3 [junit4] 2> 2295865 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2295865 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2295866 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295866 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295867 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 4 [junit4] 2> 2295870 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 4 [junit4] 2> 2295876 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 4 [junit4] 2> 2295880 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2295881 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2295881 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295882 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295882 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 5 [junit4] 2> 2295886 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 5 [junit4] 2> 2295892 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 5 [junit4] 2> 2295896 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2295896 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2295897 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295897 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295897 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 6 [junit4] 2> 2295898 T6193 oasc.ZkController.register We are https://127.0.0.1:52041/customcollreplicadeletion_b_replica1/ and leader is https://127.0.0.1:52041/customcollreplicadeletion_b_replica1/ [junit4] 2> 2295898 T6193 oasc.ZkController.register No LogReplay needed for core=customcollreplicadeletion_b_replica1 baseURL=https://127.0.0.1:52041 [junit4] 2> 2295899 T6193 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 2295899 T6193 oasc.ZkController.publish publishing core=customcollreplicadeletion_b_replica1 state=active collection=customcollreplicadeletion [junit4] 2> 2295903 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 6 [junit4] 2> 2295906 T6193 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 6 [junit4] 2> 2295909 T6193 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=customcollreplicadeletion_b_replica1&action=CREATE&numShards=2&collection=customcollreplicadeletion&shard=b&wt=javabin&version=2} status=0 QTime=1330 [junit4] 2> 2295911 T6161 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 6 [junit4] 2> 2295911 T6161 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"customcollreplicadeletion_b_replica1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:52041";, [junit4] 2> "node_name":"127.0.0.1:52041_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"active", [junit4] 2> "shard":"b", [junit4] 2> "collection":"customcollreplicadeletion", [junit4] 2> "operation":"state"} [junit4] 2> 2295914 T6169 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2295915 T6161 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/customcollreplicadeletion/state.json [junit4] 2> 2295917 T6199 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295917 T6169 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/customcollreplicadeletion/state.json, has occurred - updating... [junit4] 2> 2295919 T6199 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 7 [junit4] 2> 2295921 T6169 oascc.ZkStateReader.updateWatchedCollection Updating data for customcollreplicadeletion to ver 7 [junit4] 2> 2295940 T6154 oasc.ZkController.register We are https://127.0.0.1:52017/customcollreplicadeletion_a_replica1/ and leader is https://127.0.0.1:52017/customcollreplicadeletion_a_replica1/ [junit4] 2> 2295940 T6154 oasc.ZkController.register No LogReplay needed for core=customcollreplicadeletion_a_replica1 baseURL=https://127.0.0.1:52017 [junit4] 2> 2295940 T6154 oasc.ZkController.checkRecovery I am the leader, [...truncated too long message...] -Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DECDA0BC7458AF0F-001 [junit4] 2> NOTE: test params are: codec=Lucene410: {}, docValues:{}, sim=DefaultSimilarity, locale=ru_RU, timezone=America/Detroit [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40-ea (64-bit)/cpus=2,threads=1,free=143275000,total=397230080 [junit4] 2> NOTE: All tests run in this JVM: [TestFreeTextSuggestions, TestManagedStopFilterFactory, TestArbitraryIndexDir, XsltUpdateRequestHandlerTest, MinimalSchemaTest, CoreAdminHandlerTest, TestCloudInspectUtil, OutOfBoxZkACLAndCredentialsProvidersTest, BasicFunctionalityTest, OverseerRolesTest, TestDynamicFieldCollectionResource, TestBadConfig, TestPivotHelperCode, TestSweetSpotSimilarityFactory, ExternalFileFieldSortTest, DocumentAnalysisRequestHandlerTest, FileUtilsTest, TestDocBasedVersionConstraints, LeaderElectionTest, TestLFUCache, TestBlendedInfixSuggestions, TestAnalyzeInfixSuggestions, CircularListTest, TestSuggestSpellingConverter, XmlUpdateRequestHandlerTest, AnalyticsMergeStrategyTest, DistributedExpandComponentTest, ClusterStateTest, IndexSchemaRuntimeFieldTest, TestStressUserVersions, TestNRTOpen, MergeStrategyTest, ConvertedLegacyTest, TestIntervalFaceting, DOMUtilTest, SpellingQueryConverterTest, TestStressLucene, TestModifyConfFiles, DeleteShardTest, SchemaVersionSpecificBehaviorTest, CursorPagingTest, ConnectionManagerTest, TestConfigSets, TestWriterPerf, TestSolrJ, TestUpdate, TestPostingsSolrHighlighter, CachingDirectoryFactoryTest, TestCursorMarkWithoutUniqueKey, DistributedSpellCheckComponentTest, TestSolr4Spatial2, TestReloadAndDeleteDocs, OverseerStatusTest, OpenExchangeRatesOrgProviderTest, StressHdfsTest, TestSchemaResource, SpellPossibilityIteratorTest, TestClassNameShortening, TestRecoveryHdfs, TestRawResponseWriter, NotRequiredUniqueKeyTest, TestJmxIntegration, LoggingHandlerTest, AlternateDirectoryTest, MigrateRouteKeyTest, BadComponentTest, ResponseHeaderTest, TestValueSourceCache, ResponseLogComponentTest, CollectionsAPIAsyncDistributedZkTest, TestSchemaSimilarityResource, PreAnalyzedUpdateProcessorTest, AnalysisAfterCoreReloadTest, ResourceLoaderTest, TestSolrDeletionPolicy1, TestIndexingPerformance, TestNonNRTOpen, DistributedQueryComponentOptimizationTest, QueryElevationComponentTest, TestDistributedGrouping, TestChildDocTransformer, TestFoldingMultitermQuery, UniqFieldsUpdateProcessorFactoryTest, MoreLikeThisHandlerTest, TestFieldCollectionResource, NoCacheHeaderTest, DocValuesMissingTest, TestComponentsName, TestSearcherReuse, SortByFunctionTest, HdfsChaosMonkeySafeLeaderTest, RegexBoostProcessorTest, TestSolrQueryParserResource, CurrencyFieldOpenExchangeTest, CustomCollectionTest, SolrCmdDistributorTest, TestLMDirichletSimilarityFactory, TestUtils, TestSolrXmlPersistor, OverseerTest, TestDFRSimilarityFactory, DistribCursorPagingTest, CoreMergeIndexesAdminHandlerTest, ModifyConfFileTest, SolrRequestParserTest, SolrCoreTest, ZkCLITest, AssignTest, SignatureUpdateProcessorFactoryTest, ShardRoutingTest, TestFieldTypeCollectionResource, HighlighterConfigTest, TestCSVResponseWriter, TestOverriddenPrefixQueryForCustomFieldType, TestFileDictionaryLookup, TestReRankQParserPlugin, DistributedSuggestComponentTest, DistributedIntervalFacetingTest, TestJoin, RequestHandlersTest, FieldAnalysisRequestHandlerTest, BasicDistributedZk2Test, MultiTermTest, ChangedSchemaMergeTest, OutputWriterTest, OpenCloseCoreStressTest, TestCSVLoader, DistributedFacetPivotSmallTest, RecoveryZkTest, ExternalCollectionsTest, TestCollapseQParserPlugin, DebugComponentTest, TestOrdValues, TestTolerantSearch, URLClassifyProcessorTest, PluginInfoTest, TestRangeQuery, TestLazyCores, HdfsWriteToMultipleCollectionsTest, TestManagedResourceStorage, TestCloudManagedSchema, BlockCacheTest, TestManagedResource, TestComplexPhraseQParserPlugin, VMParamsZkACLAndCredentialsProvidersTest, TestCollectionAPI, SSLMigrationTest, HdfsDirectoryTest, SynonymTokenizerTest, CSVRequestHandlerTest, TestHighlightDedupGrouping, TestSort, TestCloudSchemaless, TestExceedMaxTermLength, SharedFSAutoReplicaFailoverUtilsTest, TestElisionMultitermQuery, BJQParserTest, HardAutoCommitTest, TestZkChroot, TestHashPartitioner, TestPartialUpdateDeduplication, DocumentBuilderTest, SliceStateTest, TestManagedSchemaFieldResource, TestReplicationHandlerBackup, UpdateParamsTest, UpdateRequestProcessorFactoryTest, StatsComponentTest, TestSearchPerf, SolrPluginUtilsTest, TestSimpleQParserPlugin, TestRequestStatusCollectionAPI, UUIDFieldTest, TestCodecSupport, DeleteLastCustomShardedReplicaTest, DistributedFacetPivotLongTailTest, StandardRequestHandlerTest, TermVectorComponentDistributedTest, TestSolrCoreProperties, HdfsSyncSliceTest, TestRTGBase, SuggesterWFSTTest, OverriddenZkACLAndCredentialsProvidersTest, SimplePostToolTest, LukeRequestHandlerTest, TestReload, TestFastWriter, TestCollationFieldDocValues, TestManagedSchema, RollingRestartTest, IndexBasedSpellCheckerTest, TestRealTimeGet, TestHighFrequencyDictionaryFactory, TestStandardQParsers, DirectSolrConnectionTest, TestInitQParser, HighlighterMaxOffsetTest, TestCopyFieldCollectionResource, AnalysisErrorHandlingTest, TestPerFieldSimilarity, TestMissingGroups, SuggestComponentTest, DirectUpdateHandlerOptimizeTest, DocValuesTest, SolrIndexConfigTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch, AutoCommitTest, TestFaceting, TestRecovery, ZkControllerTest, TestStressReorder, TestMultiCoreConfBootstrap, TestStressVersions, DistributedTermsComponentTest, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, SpellCheckComponentTest, TestGroupingSearch, PeerSyncTest, BadIndexSchemaTest, TestFiltering, TestFunctionQuery, DirectUpdateHandlerTest, OverseerCollectionProcessorTest, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterFSTTest, SuggesterTSTTest, SuggesterTest, TestTrie, SpatialFilterTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, QueryEqualityTest, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest, SolrInfoMBeanTest, CacheHeaderTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, TestQueryTypes, PrimitiveFieldTypeTest, TestOmitPositions, FileBasedSpellCheckerTest, TermsComponentTest, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest, TestSolrQueryParser, FastVectorHighlighterTest, IndexSchemaTest, TestCollationField, ReturnFieldsTest, JSONWriterTest, MBeansHandlerTest, QueryParsingTest, TestAnalyzedSuggestions, JsonLoaderTest, BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, PingRequestHandlerTest, SearchHandlerTest, CoreContainerCoreInitFailuresTest, TestBinaryResponseWriter, SOLR749Test, TestQuerySenderListener, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, TestStressRecovery, TestMergePolicyConfig, TestSolrDeletionPolicy2, SampleTest, TestDocSet, TestBinaryField, NumericFieldsTest, TestConfig, TestFuzzyAnalyzedSuggestions, TestLuceneMatchVersion, TestPhraseSuggestions, TestCharFilters, TestXIncludeConfig, EchoParamsTest, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestBM25SimilarityFactory, TestDefaultSimilarityFactory, LegacyHTMLStripCharFilterTest, TestJmxMonitoredMap, TimeZoneUtilsTest, TestFastOutputStream, ScriptEngineTest, TestFastLRUCache, DateMathParserTest, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, TestSystemIdResolver, PrimUtilsTest, DateFieldTest, RAMDirectoryFactoryTest, TestLRUCache, TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest, SolrTestCaseJ4Test, TestDistributedMissingSort, AliasIntegrationTest, AsyncMigrateRouteKeyTest, DeleteInactiveReplicaTest, DeleteReplicaTest] [junit4] Completed in 239.88s, 1 test, 1 error <<< FAILURES! [...truncated 242 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:491: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:471: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:60: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1358: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:961: There were test failures: 429 suites, 1772 tests, 2 errors, 54 ignored (32 assumptions) Total time: 143 minutes 52 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b04 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
