Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4372/ Java: 32bit/jdk1.7.0_67 -client -XX:+UseConcMarkSweepGC
2 tests failed. REGRESSION: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[https://127.0.0.1:64986/_/w, https://127.0.0.1:64944/_/w, https://127.0.0.1:64977/_/w, https://127.0.0.1:64968/_/w, https://127.0.0.1:64959/_/w] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:64986/_/w, https://127.0.0.1:64944/_/w, https://127.0.0.1:64977/_/w, https://127.0.0.1:64968/_/w, https://127.0.0.1:64959/_/w] at __randomizedtesting.SeedInfo.seed([A565F748E5B7FD60:2483795092E89D5C]:0) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:333) at org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:1015) at org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:793) at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:736) at org.apache.solr.cloud.DeleteReplicaTest.removeAndWaitForReplicaGone(DeleteReplicaTest.java:172) at org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:145) at org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:89) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor45.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) 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:569) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:354) at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:313) ... 46 more FAILED: org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.testDistribSearch Error Message: expected:<0> but was:<1> Stack Trace: java.lang.AssertionError: expected:<0> but was:<1> at __randomizedtesting.SeedInfo.seed([A565F748E5B7FD60:2483795092E89D5C]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.doTest(ChaosMonkeySafeLeaderTest.java:153) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor45.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) 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) Build Log: [...truncated 11336 lines...] [junit4] Suite: org.apache.solr.cloud.ChaosMonkeySafeLeaderTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\init-core-data-001 [junit4] 2> 3073535 T7419 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 3073535 T7419 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /x/ [junit4] 2> 3073541 T7419 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 3073544 T7419 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3073544 T7420 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 3073629 T7419 oasc.ZkTestServer.run start zk server on port:62047 [junit4] 2> 3073630 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3073631 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3073636 T7426 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1e03119 name:ZooKeeperConnection Watcher:127.0.0.1:62047 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3073637 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3073637 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3073637 T7419 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 3073641 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3073643 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3073644 T7428 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@cf22bb name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3073644 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3073645 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3073645 T7419 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 3073650 T7419 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 3073654 T7419 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 3073657 T7419 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 3073660 T7419 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> 3073660 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 3073666 T7419 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml to /configs/conf1/schema.xml [junit4] 2> 3073666 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 3073670 T7419 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> 3073670 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 3073673 T7419 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> 3073673 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 3073676 T7419 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> 3073676 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 3073680 T7419 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> 3073680 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 3073684 T7419 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> 3073684 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 3073688 T7419 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> 3073688 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 3073692 T7419 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> 3073692 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 3073696 T7419 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> 3073697 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 3073700 T7419 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> 3073700 T7419 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 3073718 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3073721 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3073722 T7430 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@91dae5 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3073722 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3073723 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3073725 T7421 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x149153074760002, 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> 3075787 T7419 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 3075803 T7419 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 3075808 T7419 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:62057 [junit4] 2> 3075811 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 3075811 T7419 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3075811 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002 [junit4] 2> 3075811 T7419 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002\' [junit4] 2> 3075845 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002\solr.xml [junit4] 2> 3075918 T7419 oasc.CoreContainer.<init> New CoreContainer 21329810 [junit4] 2> 3075918 T7419 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002\] [junit4] 2> 3075921 T7419 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 3075922 T7419 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 3075922 T7419 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 3075923 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 3075923 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 3075924 T7419 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 3075924 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 3075925 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 3075926 T7419 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 3075926 T7419 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 3075930 T7419 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 3075935 T7419 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3075935 T7419 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 3075935 T7419 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 3075936 T7419 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:62047/solr [junit4] 2> 3075936 T7419 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 3075937 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3075940 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3075942 T7441 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@156ca19 name:ZooKeeperConnection Watcher:127.0.0.1:62047 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3075942 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3075943 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3075946 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3075948 T7443 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@159bc36 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3075948 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3075950 T7419 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 3075955 T7419 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 3075959 T7419 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 3075963 T7419 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 3075968 T7419 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 3075973 T7419 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 3075977 T7419 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:62057_x [junit4] 2> 3075978 T7419 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:62057_x [junit4] 2> 3075982 T7419 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 3075985 T7419 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 3075989 T7419 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 3075991 T7419 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:62057_x [junit4] 2> 3075991 T7419 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 3075995 T7419 oasc.Overseer.start Overseer (id=92628565194309636-127.0.0.1:62057_x-n_0000000000) starting [junit4] 2> 3075998 T7419 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 3076017 T7419 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 3076018 T7445 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 3076019 T7419 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 3076025 T7419 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 3076026 T7419 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 3076034 T7444 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 3076042 T7447 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 3076043 T7447 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 3076044 T7447 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 3076044 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3076050 T7444 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "base_url":"https://127.0.0.1:62057/x", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down", [junit4] 2> "node_name":"127.0.0.1:62057_x", [junit4] 2> "operation":"state", [junit4] 2> "shard":null} [junit4] 2> 3076050 T7444 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1] [junit4] 2> 3076050 T7444 oasc.Overseer$ClusterStateUpdater.createCollection state version control_collection 1 [junit4] 2> 3076050 T7444 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 3076054 T7448 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> 3076967 T7447 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 3076967 T7447 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 3076968 T7447 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 3076968 T7447 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 3076970 T7447 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3076970 T7447 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002\collection1\' [junit4] 2> 3076973 T7447 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-002/collection1/lib/.svn/' to classloader [junit4] 2> 3076974 T7447 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-002/collection1/lib/classes/' to classloader [junit4] 2> 3076974 T7447 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-002/collection1/lib/README' to classloader [junit4] 2> 3077039 T7447 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 3077088 T7447 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 3077091 T7447 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 3077099 T7447 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 3077447 T7447 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 3077451 T7447 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 3077454 T7447 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3077460 T7447 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3077494 T7447 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 3077494 T7447 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 3077495 T7447 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-002\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/control/data\ [junit4] 2> 3077495 T7447 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@548759 [junit4] 2> 3077497 T7447 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\control\data [junit4] 2> 3077499 T7447 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/control/data\index/ [junit4] 2> 3077499 T7447 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\control\data\index' doesn't exist. Creating new index... [junit4] 2> 3077501 T7447 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\control\data\index [junit4] 2> 3077502 T7447 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1949342809, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 3077506 T7447 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\control\data\index,segFN=segments_1,generation=1} [junit4] 2> 3077506 T7447 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3077511 T7447 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 3077512 T7447 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 3077512 T7447 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 3077513 T7447 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 3077513 T7447 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 3077513 T7447 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 3077514 T7447 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3077515 T7447 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3077515 T7447 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 3077516 T7447 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3077517 T7447 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3077519 T7447 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3077520 T7447 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 3077520 T7447 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 3077520 T7447 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 3077520 T7447 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 3077521 T7447 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 3077522 T7447 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 3077522 T7447 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 3077523 T7447 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 3077532 T7447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3077535 T7447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3077537 T7447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3077538 T7447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3077542 T7447 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 3077543 T7447 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 3077544 T7447 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=22.2041015625, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=16.118088768656953, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8372763029502971 [junit4] 2> 3077545 T7447 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\control\data\index,segFN=segments_1,generation=1} [junit4] 2> 3077545 T7447 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3077545 T7447 oass.SolrIndexSearcher.<init> Opening Searcher@646752[collection1] main [junit4] 2> 3077545 T7447 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 3077547 T7447 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3077547 T7447 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 3077548 T7447 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3077548 T7447 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 3077548 T7447 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3077550 T7447 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 3077550 T7447 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3077551 T7447 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 3077555 T7447 oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new znode /configs/conf1/_rest_managed.json [junit4] 2> 3077555 T7447 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3077555 T7447 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 3077558 T7449 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@646752[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3077560 T7447 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 3077562 T7452 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:62057/x collection:control_collection shard:shard1 [junit4] 2> 3077563 T7419 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 3077563 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 3077565 T7452 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 3077571 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3077573 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3077575 T7452 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 3077575 T7454 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1106692 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3077576 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3077576 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3077578 T7419 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 3077579 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3077580 T7452 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 3077580 T7452 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C4900 name=collection1 org.apache.solr.core.SolrCore@7d2b58 url=https://127.0.0.1:62057/x/collection1 node=127.0.0.1:62057_x C4900_STATE=coll:control_collection core:collection1 props:{base_url=https://127.0.0.1:62057/x, core=collection1, state=down, node_name=127.0.0.1:62057_x} [junit4] 2> 3077580 T7452 C4900 P62057 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:62057/x/collection1/ [junit4] 2> 3077581 T7452 C4900 P62057 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 3077581 T7452 C4900 P62057 oasc.SyncStrategy.syncToMe https://127.0.0.1:62057/x/collection1/ has no replicas [junit4] 2> 3077581 T7452 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:62057/x/collection1/ shard1 [junit4] 2> 3077582 T7452 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 3077585 T7419 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 3077586 T7419 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2 [junit4] 2> 3077586 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3077589 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3077591 T7456 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ea4c40 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3077592 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3077592 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3077595 T7448 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> 3077596 T7457 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> 3077599 T7421 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x149153074760006, 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> 3077613 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3077614 T7444 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: collection1 [junit4] 2> 3077614 T7444 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1] [junit4] 2> 3077614 T7444 oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2 [junit4] 2> 3077618 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/collection1/state.json [junit4] 2> 3077620 T7448 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> 3077620 T7457 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> 3077648 T7452 oasc.ZkController.register We are https://127.0.0.1:62057/x/collection1/ and leader is https://127.0.0.1:62057/x/collection1/ [junit4] 2> 3077648 T7452 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:62057/x [junit4] 2> 3077648 T7452 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 3077648 T7452 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection [junit4] 2> 3077648 T7452 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 3077651 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3077657 T7444 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "base_url":"https://127.0.0.1:62057/x", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null, [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"control_collection", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active", [junit4] 2> "node_name":"127.0.0.1:62057_x", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1"} [junit4] 2> 3077754 T7457 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> 3077755 T7448 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> 3079287 T7419 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 3079288 T7419 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 3079301 T7419 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 3079303 T7419 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:62072 [junit4] 2> 3079308 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 3079309 T7419 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3079309 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003 [junit4] 2> 3079310 T7419 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003\' [junit4] 2> 3079351 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003\solr.xml [junit4] 2> 3079412 T7419 oasc.CoreContainer.<init> New CoreContainer 26063310 [junit4] 2> 3079412 T7419 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003\] [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 3079414 T7419 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 3079415 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 3079415 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 3079415 T7419 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 3079415 T7419 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 3079419 T7419 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 3079422 T7419 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3079422 T7419 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 3079422 T7419 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 3079422 T7419 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:62047/solr [junit4] 2> 3079423 T7419 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 3079424 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3079426 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3079428 T7468 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@18f3004 name:ZooKeeperConnection Watcher:127.0.0.1:62047 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3079428 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3079429 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3079432 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3079432 T7421 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x149153074760007, 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> 3079434 T7470 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@b1d295 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3079435 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3079445 T7419 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 3080376 T7419 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:62072_x [junit4] 2> 3080377 T7419 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:62072_x [junit4] 2> 3080385 T7419 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 3080397 T7472 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 3080397 T7472 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 3080399 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3080400 T7472 oasc.ZkController.preRegister Registering watch for external collection collection1 [junit4] 2> 3080401 T7472 oascc.ZkStateReader.addZkWatch addZkWatch collection1 [junit4] 2> 3080401 T7472 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper... [junit4] 2> 3080404 T7472 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 0 [junit4] 2> 3080404 T7472 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 3080406 T7444 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "base_url":"https://127.0.0.1:62072/x", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null, [junit4] 2> "collection":"collection1", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down", [junit4] 2> "node_name":"127.0.0.1:62072_x", [junit4] 2> "operation":"state", [junit4] 2> "shard":null} [junit4] 2> 3080411 T7444 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1 [junit4] 2> 3080412 T7444 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 3080421 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 3080423 T7471 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3080423 T7471 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 1 [junit4] 2> 3081327 T7472 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 3081327 T7472 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 3081328 T7472 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 3081328 T7472 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 3081329 T7472 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3081330 T7472 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003\collection1\' [junit4] 2> 3081330 T7472 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-003/collection1/lib/.svn/' to classloader [junit4] 2> 3081333 T7472 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-003/collection1/lib/classes/' to classloader [junit4] 2> 3081333 T7472 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-003/collection1/lib/README' to classloader [junit4] 2> 3081395 T7472 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 3081465 T7472 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 3081466 T7472 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 3081477 T7472 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 3081838 T7472 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 3081839 T7472 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 3081842 T7472 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3081847 T7472 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3081877 T7472 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 3081877 T7472 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 3081878 T7472 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-003\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/jetty1\ [junit4] 2> 3081878 T7472 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@548759 [junit4] 2> 3081880 T7472 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty1 [junit4] 2> 3081881 T7472 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/jetty1\index/ [junit4] 2> 3081881 T7472 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty1\index' doesn't exist. Creating new index... [junit4] 2> 3081883 T7472 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty1\index [junit4] 2> 3081884 T7472 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1949342809, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 3081910 T7472 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty1\index,segFN=segments_1,generation=1} [junit4] 2> 3081911 T7472 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3081914 T7472 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 3081914 T7472 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 3081915 T7472 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 3081915 T7472 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 3081915 T7472 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 3081915 T7472 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 3081916 T7472 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3081916 T7472 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3081916 T7472 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 3081917 T7472 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3081918 T7472 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3081919 T7472 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3081919 T7472 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 3081920 T7472 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 3081920 T7472 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 3081920 T7472 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 3081921 T7472 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 3081921 T7472 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 3081922 T7472 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 3081923 T7472 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 3081931 T7472 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3081933 T7472 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3081935 T7472 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3081938 T7472 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3081941 T7472 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 3081942 T7472 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 3081943 T7472 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=22.2041015625, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=16.118088768656953, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8372763029502971 [junit4] 2> 3081944 T7472 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty1\index,segFN=segments_1,generation=1} [junit4] 2> 3081944 T7472 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3081944 T7472 oass.SolrIndexSearcher.<init> Opening Searcher@e055cb[collection1] main [junit4] 2> 3081945 T7472 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 3081947 T7472 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3081947 T7472 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 3081948 T7472 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3081948 T7472 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 3081948 T7472 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3081949 T7472 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 3081949 T7472 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3081949 T7472 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 3081949 T7472 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 3081955 T7473 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e055cb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3081959 T7472 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 3081960 T7476 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:62072/x collection:collection1 shard:shard1 [junit4] 2> 3081961 T7419 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 3081961 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 3081963 T7476 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election [junit4] 2> 3081975 T7476 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 3081978 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3081980 T7476 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 3081980 T7476 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C4901 name=collection1 org.apache.solr.core.SolrCore@16dd81c url=https://127.0.0.1:62072/x/collection1 node=127.0.0.1:62072_x C4901_STATE=coll:collection1 core:collection1 props:{base_url=https://127.0.0.1:62072/x, core=collection1, state=down, node_name=127.0.0.1:62072_x} [junit4] 2> 3081980 T7476 C4901 P62072 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:62072/x/collection1/ [junit4] 2> 3081980 T7476 C4901 P62072 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 3081982 T7476 C4901 P62072 oasc.SyncStrategy.syncToMe https://127.0.0.1:62072/x/collection1/ has no replicas [junit4] 2> 3081982 T7476 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:62072/x/collection1/ shard1 [junit4] 2> 3081982 T7476 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1 [junit4] 2> 3082003 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 3082005 T7471 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3082006 T7471 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 2 [junit4] 2> 3082017 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3082018 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 3082019 T7471 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3082021 T7471 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3 [junit4] 2> 3082049 T7476 oasc.ZkController.register We are https://127.0.0.1:62072/x/collection1/ and leader is https://127.0.0.1:62072/x/collection1/ [junit4] 2> 3082049 T7476 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:62072/x [junit4] 2> 3082049 T7476 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 3082050 T7476 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 3082050 T7476 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 3082053 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3082063 T7444 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "base_url":"https://127.0.0.1:62072/x", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null, [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"collection1", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active", [junit4] 2> "node_name":"127.0.0.1:62072_x", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1"} [junit4] 2> 3082064 T7476 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3 [junit4] 2> 3082075 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 3082076 T7471 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3082079 T7471 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4 [junit4] 2> 3083551 T7419 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 3083551 T7419 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 3083567 T7419 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 3083570 T7419 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:62081 [junit4] 2> 3083575 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 3083575 T7419 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3083575 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004 [junit4] 2> 3083575 T7419 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004\' [junit4] 2> 3083608 T7419 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004\solr.xml [junit4] 2> 3083698 T7419 oasc.CoreContainer.<init> New CoreContainer 11801336 [junit4] 2> 3083699 T7419 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004\] [junit4] 2> 3083700 T7419 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 3083701 T7419 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 3083706 T7419 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 3083710 T7419 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3083710 T7419 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 3083711 T7419 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 3083711 T7419 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:62047/solr [junit4] 2> 3083712 T7419 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 3083712 T7419 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 3083716 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3083719 T7487 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a5e843 name:ZooKeeperConnection Watcher:127.0.0.1:62047 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3083719 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3083720 T7419 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 3083724 T7419 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 3083725 T7489 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e1cb14 name:ZooKeeperConnection Watcher:127.0.0.1:62047/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3083725 T7419 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 3083738 T7419 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 3084763 T7419 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:62081_x [junit4] 2> 3084765 T7419 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:62081_x [junit4] 2> 3084775 T7419 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 3084788 T7491 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 3084788 T7491 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 3084791 T7448 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 3084793 T7491 oasc.ZkController.preRegister Registering watch for external collection collection1 [junit4] 2> 3084794 T7491 oascc.ZkStateReader.addZkWatch addZkWatch collection1 [junit4] 2> 3084795 T7491 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper... [junit4] 2> 3084798 T7491 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4 [junit4] 2> 3084799 T7491 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 3084801 T7444 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "base_url":"https://127.0.0.1:62081/x", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null, [junit4] 2> "collection":"collection1", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down", [junit4] 2> "node_name":"127.0.0.1:62081_x", [junit4] 2> "operation":"state", [junit4] 2> "shard":null} [junit4] 2> 3084807 T7444 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=1 [junit4] 2> 3084810 T7444 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 3084820 T7444 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 3084821 T7471 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3084822 T7490 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 3084822 T7471 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5 [junit4] 2> 3084823 T7490 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5 [junit4] 2> 3085814 T7491 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 3085814 T7491 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 3085816 T7491 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 3085816 T7491 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 3085818 T7491 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3085818 T7491 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004\collection1\' [junit4] 2> 3085822 T7491 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-004/collection1/lib/.svn/' to classloader [junit4] 2> 3085824 T7491 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-004/collection1/lib/classes/' to classloader [junit4] 2> 3085826 T7491 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001/tempDir-004/collection1/lib/README' to classloader [junit4] 2> 3085896 T7491 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 3085962 T7491 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 3085965 T7491 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 3085976 T7491 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 3086377 T7491 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 3086397 T7491 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 3086399 T7491 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3086408 T7491 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 3086455 T7491 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 3086456 T7491 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 3086456 T7491 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-004\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/jetty2\ [junit4] 2> 3086456 T7491 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@548759 [junit4] 2> 3086458 T7491 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty2 [junit4] 2> 3086459 T7491 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.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001/jetty2\index/ [junit4] 2> 3086460 T7491 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty2\index' doesn't exist. Creating new index... [junit4] 2> 3086462 T7491 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty2\index [junit4] 2> 3086462 T7491 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1949342809, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 3086467 T7491 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty2\index,segFN=segments_1,generation=1} [junit4] 2> 3086467 T7491 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3086473 T7491 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 3086475 T7491 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 3086475 T7491 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 3086475 T7491 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 3086476 T7491 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 3086476 T7491 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 3086477 T7491 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3086478 T7491 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 3086478 T7491 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 3086480 T7491 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3086481 T7491 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3086482 T7491 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 3086483 T7491 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 3086485 T7491 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 3086485 T7491 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 3086485 T7491 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 3086487 T7491 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 3086488 T7491 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 3086489 T7491 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 3086490 T7491 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 3086504 T7491 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3086507 T7491 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3086509 T7491 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3086511 T7491 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 3086514 T7491 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 3086514 T7491 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 3086517 T7491 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=22.2041015625, floorSegmentMB=1.9912109375, forceMergeDeletesPctAllowed=16.118088768656953, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8372763029502971 [junit4] 2> 3086519 T7491 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeySafeLeaderTest-A565F748E5B7FD60-001\tempDir-001\jetty2\index,segFN=segments_1,generation=1} [junit4] 2> 3086520 T7491 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 3086520 T7491 oass.SolrIndexSearcher.<init> Opening Searcher@e7734b[collection1] main [junit4] 2> 3086521 T7491 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 3086524 T7491 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 3086524 T7491 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 3086525 T7491 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3086525 T7491 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 3086525 T7491 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3086529 T7491 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 3086529 T7491 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3086529 T7491 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 3086529 T7491 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 3086537 T7492 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e7734b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3086542 T7491 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 3086544 T7495 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:62081/x collection:collection1 shard:shard1 [junit4] 2> 3086545 T7419 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 3086545 T7419 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 3086550 T7495 oasc.ZkController.register We are https://127.0.0.1:62081/x/collection1/ and leader is https://127.0.0.1:62072/x/collection1/ [...truncated too long message...] FD60-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=en_CA, timezone=America/Bogota [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_67 (32-bit)/cpus=2,threads=1,free=334462184,total=523501568 [junit4] 2> NOTE: All tests run in this JVM: [PluginInfoTest, TestDefaultSearchFieldResource, DirectSolrSpellCheckerTest, TestBulkSchemaConcurrent, CloudExitableDirectoryReaderTest, URLClassifyProcessorTest, TestFileDictionaryLookup, AsyncMigrateRouteKeyTest, BasicFunctionalityTest, TestSearchPerf, OpenCloseCoreStressTest, TestDistributedSearch, TestBM25SimilarityFactory, TestSolr4Spatial2, TestDistributedMissingSort, TestFiltering, DisMaxRequestHandlerTest, TestPostingsSolrHighlighter, XmlUpdateRequestHandlerTest, SolrIndexSplitterTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestClassNameShortening, TestRandomDVFaceting, TestChildDocTransformer, DistribCursorPagingTest, IndexBasedSpellCheckerTest, TestUniqueKeyFieldResource, HdfsBasicDistributedZk2Test, StressHdfsTest, SolrXmlInZkTest, TestCloudPivotFacet, CursorMarkTest, TestSweetSpotSimilarityFactory, TestSimpleQParserPlugin, UpdateParamsTest, TestManagedSchemaFieldTypeResource, TestModifyConfFiles, SyncSliceTest, SolrPluginUtilsTest, TestMergePolicyConfig, TestSchemaVersionResource, NoCacheHeaderTest, TestMiniSolrCloudCluster, OverseerRolesTest, TestLRUCache, TestPHPSerializedResponseWriter, TestRestManager, TestFieldSortValues, UUIDFieldTest, BlockDirectoryTest, RankQueryTest, LeaderFailoverAfterPartitionTest, TestPhraseSuggestions, TestManagedSynonymFilterFactory, DocValuesTest, WordBreakSolrSpellCheckerTest, JSONWriterTest, TestElisionMultitermQuery, ExitableDirectoryReaderTest, AssignTest, FastVectorHighlighterTest, QueryParsingTest, PingRequestHandlerTest, DistributedIntervalFacetingTest, BadIndexSchemaTest, AutoCommitTest, TestSchemaNameResource, DistributedTermsComponentTest, DistributedDebugComponentTest, DistribDocExpirationUpdateProcessorTest, DistanceFunctionTest, HdfsSyncSliceTest, SpellCheckCollatorTest, RollingRestartTest, DefaultValueUpdateProcessorTest, ParsingFieldUpdateProcessorsTest, DeleteShardTest, TestCodecSupport, OpenExchangeRatesOrgProviderTest, TestExtendedDismaxParser, TestStressLucene, LeaderInitiatedRecoveryOnCommitTest, NumericFieldsTest, TestRandomMergePolicy, TestNRTOpen, TestFieldTypeCollectionResource, TestDynamicFieldResource, CachingDirectoryFactoryTest, TestManagedSchemaFieldResource, SuggesterWFSTTest, SuggesterTSTTest, TestSolrCoreProperties, TestManagedResource, TestRTGBase, TestLazyCores, TestSolrXmlPersistor, CurrencyFieldXmlFileTest, SolrTestCaseJ4Test, FileUtilsTest, TestCollationFieldDocValues, TestLFUCache, HdfsUnloadDistributedZkTest, TestDFRSimilarityFactory, SimpleFacetsTest, AliasIntegrationTest, TestStressReorder, CoreAdminCreateDiscoverTest, TestZkChroot, DistributedQueryComponentCustomSortTest, ZkCLITest, TestManagedSchema, TermsComponentTest, TestExceedMaxTermLength, ZkNodePropsTest, CustomCollectionTest, TestSort, StandardRequestHandlerTest, ZkSolrClientTest, TestFastOutputStream, HdfsWriteToMultipleCollectionsTest, UUIDUpdateProcessorFallbackTest, TestQueryTypes, SpatialFilterTest, PrimitiveFieldTypeTest, TestAnalyzedSuggestions, MoreLikeThisHandlerTest, UnloadDistributedZkTest, TestDocBasedVersionConstraints, TestSystemIdResolver, TestShortCircuitedRequests, SSLMigrationTest, DistributedSpellCheckComponentTest, ClusterStateUpdateTest, UniqFieldsUpdateProcessorFactoryTest, TestQueryUtils, TestJmxIntegration, IndexSchemaTest, BadComponentTest, EnumFieldTest, TestFreeTextSuggestions, VMParamsZkACLAndCredentialsProvidersTest, DocumentAnalysisRequestHandlerTest, TestCSVResponseWriter, TestReplicationHandlerBackup, TestDynamicFieldCollectionResource, RequestHandlersTest, PeerSyncTest, TestFoldingMultitermQuery, QueryResultKeyTest, BasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, TestComplexPhraseQParserPlugin, TestOverriddenPrefixQueryForCustomFieldType, CursorPagingTest, CoreContainerCoreInitFailuresTest, ResponseLogComponentTest, SolrCoreTest, RequiredFieldsTest, TestLMDirichletSimilarityFactory, TestSerializedLuceneMatchVersion, TestJoin, TestFieldCollectionResource, DateMathParserTest, TestSolrQueryParserResource, TestDistribDocBasedVersion, SolrRequestParserTest, LoggingHandlerTest, InfoHandlerTest, ChangedSchemaMergeTest, HdfsRecoveryZkTest, CoreMergeIndexesAdminHandlerTest, TestCloudSchemaless, TestFieldTypeResource, TestPartialUpdateDeduplication, SharedFSAutoReplicaFailoverUtilsTest, TestXIncludeConfig, TestCollapseQParserPlugin, TestJmxMonitoredMap, SampleTest, MigrateRouteKeyTest, TestSuggestSpellingConverter, TestCollationField, SolrCoreCheckLockOnStartupTest, NotRequiredUniqueKeyTest, TestReRankQParserPlugin, SystemInfoHandlerTest, TestAtomicUpdateErrorCases, TestSurroundQueryParser, TestInitQParser, TestUtils, ScriptEngineTest, TestRandomFaceting, CurrencyFieldOpenExchangeTest, DebugComponentTest, DistributedFacetPivotLongTailTest, ChaosMonkeySafeLeaderTest, AlternateDirectoryTest, ExternalFileFieldSortTest, TestIntervalFaceting, TestReloadAndDeleteDocs, ZkControllerTest, ShowFileRequestHandlerTest, TestManagedSchemaDynamicFieldResource, FullSolrCloudDistribCmdsTest, CollectionsAPIDistributedZkTest, LukeRequestHandlerTest, TestRequestStatusCollectionAPI, UpdateRequestProcessorFactoryTest, AnalysisAfterCoreReloadTest, ShardSplitTest, TestStandardQParsers, SuggesterFSTTest, PolyFieldTest, PrimUtilsTest, TestSolrDeletionPolicy2, BasicDistributedZk2Test, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, BasicZkTest, RecoveryZkTest, TestReplicationHandler, LeaderElectionTest, ShardRoutingCustomTest, TestDistributedGrouping, TestFaceting, TestRecovery, TestHashPartitioner, TermVectorComponentDistributedTest, TestRealTimeGet, TestMultiCoreConfBootstrap, TestReload, TestStressVersions, HardAutoCommitTest, TestRangeQuery, TestCoreContainer, TestSolr4Spatial, StatsComponentTest, SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest, QueryElevationComponentTest, ConvertedLegacyTest, TestFunctionQuery, DirectUpdateHandlerTest, TestBadConfig, OverseerCollectionProcessorTest, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, DistributedQueryElevationComponentTest, SimplePostToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, CoreAdminHandlerTest, SuggesterTest, TestTrie, TestCSVLoader, SchemaVersionSpecificBehaviorTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, TestWordDelimiterFilterFactory, QueryEqualityTest, DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, TestSolrDeletionPolicy1, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, TestWriterPerf, TestReversedWildcardFilterFactory, TestOmitPositions, FileBasedSpellCheckerTest, DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, TestIndexingPerformance, FieldAnalysisRequestHandlerTest, TestSolrQueryParser, TestArbitraryIndexDir, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, ReturnFieldsTest, MBeansHandlerTest, JsonLoaderTest, BinaryUpdateRequestHandlerTest, CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, TestBinaryResponseWriter, HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, SolrIndexConfigTest, TestStressRecovery, MultiTermTest, TestDocSet, TestBinaryField, MinimalSchemaTest, TestConfig, OutputWriterTest, TestFuzzyAnalyzedSuggestions, DirectSolrConnectionTest, TestLuceneMatchVersion, SpellPossibilityIteratorTest, TestCharFilters, SynonymTokenizerTest, EchoParamsTest, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestDefaultSimilarityFactory, TestFastWriter, LegacyHTMLStripCharFilterTest, TimeZoneUtilsTest, ResourceLoaderTest, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, DateFieldTest, SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestDocumentBuilder, SliceStateTest, CircularListTest, TestCursorMarkWithoutUniqueKey, TestHighlightDedupGrouping, TestTolerantSearch, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, DeleteInactiveReplicaTest, DeleteReplicaTest] [junit4] Completed in 240.27s, 1 test, 1 error <<< FAILURES! [...truncated 277 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:524: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:472: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: 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:1359: 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: 437 suites, 1784 tests, 1 error, 1 failure, 52 ignored (30 assumptions) Total time: 183 minutes 17 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 32bit/jdk1.7.0_67 -client -XX:+UseConcMarkSweepGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org