Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4277/ Java: 64bit/jdk1.8.0_20 -XX:+UseCompressedOops -XX:+UseG1GC
3 tests failed. REGRESSION: org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[http://127.0.0.1:57368/x_nar/hs, http://127.0.0.1:57383/x_nar/hs, http://127.0.0.1:57392/x_nar/hs] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:57368/x_nar/hs, http://127.0.0.1:57383/x_nar/hs, http://127.0.0.1:57392/x_nar/hs] at __randomizedtesting.SeedInfo.seed([A34DE7C4D0639203:22AB69DCA73CF23F]: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.DeleteLastCustomShardedReplicaTest.removeAndWaitForLastReplicaGone(DeleteLastCustomShardedReplicaTest.java:117) at org.apache.solr.cloud.DeleteLastCustomShardedReplicaTest.doTest(DeleteLastCustomShardedReplicaTest.java:107) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor36.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not remove replica : customcollreplicadeletion/a/core_node2 at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java: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) ... 45 more REGRESSION: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[http://127.0.0.1:57464, http://127.0.0.1:57422, http://127.0.0.1:57455, http://127.0.0.1:57446, http://127.0.0.1:57437] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:57464, http://127.0.0.1:57422, http://127.0.0.1:57455, http://127.0.0.1:57446, http://127.0.0.1:57437] at __randomizedtesting.SeedInfo.seed([A34DE7C4D0639203:22AB69DCA73CF23F]: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.GeneratedMethodAccessor36.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not remove replica : delLiveColl/shard1/core_node1 at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java: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 REGRESSION: org.apache.solr.cloud.ShardRoutingTest.testDistribSearch Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:59609/rhg/ze/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:59609/rhg/ze/collection1 at __randomizedtesting.SeedInfo.seed([A34DE7C4D0639203:22AB69DCA73CF23F]:0) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:581) 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.request.QueryRequest.process(QueryRequest.java:91) at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301) at org.apache.solr.cloud.ShardRoutingTest.doAtomicUpdate(ShardRoutingTest.java:320) at org.apache.solr.cloud.ShardRoutingTest.doTest(ShardRoutingTest.java:124) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:150) at java.net.SocketInputStream.read(SocketInputStream.java:121) at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) at sun.security.ssl.InputRecord.read(InputRecord.java:503) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:954) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:911) at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:465) ... 47 more Build Log: [...truncated 10978 lines...] [junit4] Suite: org.apache.solr.cloud.ShardRoutingTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\init-core-data-001 [junit4] 2> 417119 T1027 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 417119 T1027 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /rhg/ze [junit4] 2> 417122 T1027 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 417124 T1027 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 417125 T1028 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 417212 T1027 oasc.ZkTestServer.run start zk server on port:59584 [junit4] 2> 417212 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 417214 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 417229 T1034 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@37a60a74 name:ZooKeeperConnection Watcher:127.0.0.1:59584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 417230 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 417230 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 417230 T1027 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 417235 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 417237 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 417240 T1036 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e6c61ac name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 417240 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 417240 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 417240 T1027 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 417244 T1027 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 417248 T1027 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 417250 T1027 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 417253 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 417254 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 417257 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml to /configs/conf1/schema.xml [junit4] 2> 417257 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 417262 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 417262 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 417265 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 417265 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 417269 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 417269 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 417273 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 417273 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 417276 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 417276 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 417288 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 417288 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 417292 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 417292 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 417296 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 417296 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 417299 T1027 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 417299 T1027 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 417303 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 417305 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 417308 T1038 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@68ad2879 name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 417308 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 417308 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 418808 T1027 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 418838 T1027 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 418844 T1027 oejs.AbstractConnector.doStart Started [email protected]:59594 [junit4] 2> 418848 T1027 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 418848 T1027 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 418848 T1027 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002 [junit4] 2> 418848 T1027 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002\' [junit4] 2> 418874 T1027 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002\solr.xml [junit4] 2> 418902 T1027 oasc.CoreContainer.<init> New CoreContainer 720413091 [junit4] 2> 418902 T1027 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002\] [junit4] 2> 418903 T1027 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 418903 T1027 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 418903 T1027 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 418903 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 418905 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 418905 T1027 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 418905 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 418905 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 418905 T1027 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 418907 T1027 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 418911 T1027 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 418915 T1027 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 418915 T1027 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 418916 T1027 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 418916 T1027 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59584/solr [junit4] 2> 418916 T1027 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 418916 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 418925 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 418940 T1049 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5e9a5efb name:ZooKeeperConnection Watcher:127.0.0.1:59584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 418941 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 418941 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 418952 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 418958 T1051 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@576fa079 name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 418959 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 418961 T1027 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 418967 T1027 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 418971 T1027 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 418975 T1027 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 418979 T1027 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 418984 T1027 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 418986 T1027 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59594_rhg%2Fze [junit4] 2> 418988 T1027 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59594_rhg%2Fze [junit4] 2> 418991 T1027 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 418995 T1027 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 418997 T1027 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 419001 T1027 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:59594_rhg%2Fze [junit4] 2> 419001 T1027 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 419003 T1027 oasc.Overseer.start Overseer (id=92643398816301060-127.0.0.1:59594_rhg%2Fze-n_0000000000) starting [junit4] 2> 419007 T1027 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 419020 T1027 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 419026 T1053 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 419027 T1027 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 419033 T1027 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 419037 T1027 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 419053 T1052 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 419055 T1055 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 419055 T1055 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 419057 T1055 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 419061 T1052 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:59594/rhg/ze";, [junit4] 2> "node_name":"127.0.0.1:59594_rhg%2Fze", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 419061 T1052 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1] [junit4] 2> 419061 T1052 oasc.Overseer$ClusterStateUpdater.createCollection state version control_collection 1 [junit4] 2> 419061 T1052 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 419066 T1057 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> 419389 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 419922 T1055 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 419922 T1055 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 419922 T1055 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 419922 T1055 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 419925 T1055 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 419925 T1055 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002\collection1\' [junit4] 2> 419931 T1055 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-002/collection1/lib/.svn/' to classloader [junit4] 2> 419932 T1055 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-002/collection1/lib/classes/' to classloader [junit4] 2> 419933 T1055 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-002/collection1/lib/README' to classloader [junit4] 2> 420005 T1055 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 420090 T1055 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 420094 T1055 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 420134 T1055 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 420330 T1055 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 420330 T1055 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 420340 T1055 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 420469 T1055 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 420492 T1055 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 420492 T1055 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 420492 T1055 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-002\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/control/data\ [junit4] 2> 420492 T1055 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f7f2d93 [junit4] 2> 420496 T1055 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\control\data [junit4] 2> 420498 T1055 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/control/data\index/ [junit4] 2> 420498 T1055 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\control\data\index' doesn't exist. Creating new index... [junit4] 2> 420503 T1055 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\control\data\index [junit4] 2> 420503 T1055 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=14.04296875, floorSegmentMB=0.40234375, forceMergeDeletesPctAllowed=26.924871955907822, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6098748653981755 [junit4] 2> 420508 T1055 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\control\data\index,segFN=segments_1,generation=1} [junit4] 2> 420508 T1055 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 420511 T1055 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 420512 T1055 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 420512 T1055 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 420512 T1055 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 420513 T1055 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 420513 T1055 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 420513 T1055 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 420513 T1055 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 420513 T1055 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 420513 T1055 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 420514 T1055 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 420514 T1055 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 420514 T1055 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 420516 T1055 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 420516 T1055 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 420516 T1055 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 420516 T1055 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 420517 T1055 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 420517 T1055 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 420517 T1055 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 420524 T1055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 420525 T1055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 420527 T1055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 420529 T1055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 420530 T1055 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 420530 T1055 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 420532 T1055 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=77.6640625, floorSegmentMB=0.900390625, forceMergeDeletesPctAllowed=9.450488203809943, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 420534 T1055 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\control\data\index,segFN=segments_1,generation=1} [junit4] 2> 420534 T1055 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 420534 T1055 oass.SolrIndexSearcher.<init> Opening Searcher@4e2a5322[collection1] main [junit4] 2> 420534 T1055 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 420536 T1055 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 420536 T1055 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 420537 T1055 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 420537 T1055 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 420537 T1055 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 420538 T1055 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 420538 T1055 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 420539 T1055 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 420541 T1055 oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new znode /configs/conf1/_rest_managed.json [junit4] 2> 420541 T1055 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 420541 T1055 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 420546 T1055 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 420548 T1058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4e2a5322[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 420549 T1027 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 420549 T1027 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 420561 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 420567 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 420569 T1061 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:59594/rhg/ze collection:control_collection shard:shard1 [junit4] 2> 420572 T1063 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@132b4a24 name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 420573 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 420573 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 420578 T1027 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 420579 T1061 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 420588 T1027 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 420588 T1027 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2 [junit4] 2> 420588 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 420599 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 420605 T1065 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@65e89b72 name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 420605 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 420605 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 420626 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 420740 T1061 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 420745 T1052 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: collection1 [junit4] 2> 420745 T1052 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2, shard3, shard4] [junit4] 2> 420745 T1052 oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2 [junit4] 2> 420748 T1061 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 420748 T1061 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C140 name=collection1 org.apache.solr.core.SolrCore@6709b609 url=https://127.0.0.1:59594/rhg/ze/collection1 node=127.0.0.1:59594_rhg%2Fze C140_STATE=coll:control_collection core:collection1 props:{core=collection1, base_url=https://127.0.0.1:59594/rhg/ze, node_name=127.0.0.1:59594_rhg%2Fze, state=down} [junit4] 2> 420749 T1061 C140 P59594 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:59594/rhg/ze/collection1/ [junit4] 2> 420749 T1061 C140 P59594 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 420749 T1061 C140 P59594 oasc.SyncStrategy.syncToMe https://127.0.0.1:59594/rhg/ze/collection1/ has no replicas [junit4] 2> 420749 T1061 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:59594/rhg/ze/collection1/ shard1 [junit4] 2> 420750 T1061 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 420757 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/collection1/state.json [junit4] 2> 420762 T1056 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> 420765 T1066 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> 420790 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 420892 T1066 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> 420893 T1056 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> 420957 T1061 oasc.ZkController.register We are https://127.0.0.1:59594/rhg/ze/collection1/ and leader is https://127.0.0.1:59594/rhg/ze/collection1/ [junit4] 2> 420957 T1061 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:59594/rhg/ze [junit4] 2> 420957 T1061 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 420978 T1061 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection [junit4] 2> 420978 T1061 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 420981 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 420990 T1052 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:59594/rhg/ze";, [junit4] 2> "node_name":"127.0.0.1:59594_rhg%2Fze", [junit4] 2> "numShards":"4", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 421082 T1066 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> 421083 T1056 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> 422412 T1027 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 422413 T1027 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 422427 T1027 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 422428 T1027 oejs.AbstractConnector.doStart Started [email protected]:59609 [junit4] 2> 422434 T1027 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 422434 T1027 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 422435 T1027 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003 [junit4] 2> 422435 T1027 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003\' [junit4] 2> 422484 T1027 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003\solr.xml [junit4] 2> 422519 T1027 oasc.CoreContainer.<init> New CoreContainer 1325589294 [junit4] 2> 422521 T1027 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003\] [junit4] 2> 422522 T1027 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 422522 T1027 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 422522 T1027 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 422522 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 422523 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 422524 T1027 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 422525 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 422525 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 422525 T1027 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 422525 T1027 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 422530 T1027 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 422534 T1027 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 422535 T1027 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 422535 T1027 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 422535 T1027 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59584/solr [junit4] 2> 422535 T1027 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 422535 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 422542 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 422549 T1077 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5df16471 name:ZooKeeperConnection Watcher:127.0.0.1:59584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 422550 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 422550 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 422557 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 422563 T1079 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@bc0f1bc name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 422563 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 422576 T1027 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 423452 T1027 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59609_rhg%2Fze [junit4] 2> 423453 T1027 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59609_rhg%2Fze [junit4] 2> 423464 T1027 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 423474 T1081 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 423474 T1081 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 423477 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 423479 T1081 oasc.ZkController.preRegister Registering watch for external collection collection1 [junit4] 2> 423480 T1081 oascc.ZkStateReader.addZkWatch addZkWatch collection1 [junit4] 2> 423480 T1081 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper... [junit4] 2> 423484 T1081 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 0 [junit4] 2> 423484 T1081 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 423485 T1052 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:59609/rhg/ze";, [junit4] 2> "node_name":"127.0.0.1:59609_rhg%2Fze", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 423491 T1052 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4 [junit4] 2> 423492 T1052 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2 [junit4] 2> 423501 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 423503 T1080 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 423505 T1080 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 1 [junit4] 2> 424348 T1081 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 424348 T1081 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 424351 T1081 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 424351 T1081 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 424355 T1081 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 424355 T1081 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003\collection1\' [junit4] 2> 424358 T1081 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-003/collection1/lib/.svn/' to classloader [junit4] 2> 424360 T1081 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-003/collection1/lib/classes/' to classloader [junit4] 2> 424362 T1081 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-003/collection1/lib/README' to classloader [junit4] 2> 424422 T1081 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 424441 T1081 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 424448 T1081 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 424458 T1081 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 424724 T1081 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 424727 T1081 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 424728 T1081 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 424760 T1081 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 424804 T1081 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 424804 T1081 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 424806 T1081 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-003\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/jetty1\ [junit4] 2> 424806 T1081 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f7f2d93 [junit4] 2> 424808 T1081 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty1 [junit4] 2> 424810 T1081 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/jetty1\index/ [junit4] 2> 424810 T1081 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty1\index' doesn't exist. Creating new index... [junit4] 2> 424811 T1081 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty1\index [junit4] 2> 424813 T1081 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=14.04296875, floorSegmentMB=0.40234375, forceMergeDeletesPctAllowed=26.924871955907822, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6098748653981755 [junit4] 2> 424819 T1081 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty1\index,segFN=segments_1,generation=1} [junit4] 2> 424819 T1081 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 424823 T1081 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 424824 T1081 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 424824 T1081 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 424824 T1081 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 424825 T1081 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 424825 T1081 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 424826 T1081 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 424826 T1081 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 424826 T1081 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 424827 T1081 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 424827 T1081 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 424829 T1081 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 424829 T1081 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 424830 T1081 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 424830 T1081 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 424830 T1081 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 424831 T1081 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 424831 T1081 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 424832 T1081 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 424832 T1081 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 424841 T1081 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 424842 T1081 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 424844 T1081 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 424846 T1081 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 424850 T1081 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 424850 T1081 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 424851 T1081 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=77.6640625, floorSegmentMB=0.900390625, forceMergeDeletesPctAllowed=9.450488203809943, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 424857 T1081 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty1\index,segFN=segments_1,generation=1} [junit4] 2> 424857 T1081 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 424858 T1081 oass.SolrIndexSearcher.<init> Opening Searcher@6b22ea18[collection1] main [junit4] 2> 424858 T1081 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 424860 T1081 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 424860 T1081 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 424861 T1081 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 424861 T1081 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 424861 T1081 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 424861 T1081 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 424861 T1081 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 424861 T1081 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 424861 T1081 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 424866 T1081 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 424867 T1082 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b22ea18[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 424870 T1085 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:59609/rhg/ze collection:collection1 shard:shard2 [junit4] 2> 424873 T1027 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 424873 T1027 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 424897 T1085 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election [junit4] 2> 424914 T1085 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2 [junit4] 2> 424918 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 424919 T1085 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 424919 T1085 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C141 name=collection1 org.apache.solr.core.SolrCore@54071775 url=https://127.0.0.1:59609/rhg/ze/collection1 node=127.0.0.1:59609_rhg%2Fze C141_STATE=coll:collection1 core:collection1 props:{core=collection1, base_url=https://127.0.0.1:59609/rhg/ze, node_name=127.0.0.1:59609_rhg%2Fze, state=down} [junit4] 2> 424919 T1085 C141 P59609 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:59609/rhg/ze/collection1/ [junit4] 2> 424921 T1085 C141 P59609 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 424921 T1085 C141 P59609 oasc.SyncStrategy.syncToMe https://127.0.0.1:59609/rhg/ze/collection1/ has no replicas [junit4] 2> 424921 T1085 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:59609/rhg/ze/collection1/ shard2 [junit4] 2> 424921 T1085 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2 [junit4] 2> 424956 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 424958 T1080 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 424960 T1080 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 2 [junit4] 2> 424991 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 424991 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 424993 T1080 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 424995 T1080 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3 [junit4] 2> 425013 T1085 oasc.ZkController.register We are https://127.0.0.1:59609/rhg/ze/collection1/ and leader is https://127.0.0.1:59609/rhg/ze/collection1/ [junit4] 2> 425013 T1085 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:59609/rhg/ze [junit4] 2> 425013 T1085 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 425013 T1085 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 425013 T1085 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 425076 T1085 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 3 [junit4] 2> 425079 T1052 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:59609/rhg/ze";, [junit4] 2> "node_name":"127.0.0.1:59609_rhg%2Fze", [junit4] 2> "numShards":"4", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 425091 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 425091 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 425093 T1080 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 425095 T1080 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4 [junit4] 2> 426692 T1027 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 426693 T1027 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 426704 T1027 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 426707 T1027 oejs.AbstractConnector.doStart Started [email protected]:59618 [junit4] 2> 426715 T1027 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 426716 T1027 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 426716 T1027 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004 [junit4] 2> 426716 T1027 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004\' [junit4] 2> 426748 T1027 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004\solr.xml [junit4] 2> 426765 T1027 oasc.CoreContainer.<init> New CoreContainer 892083064 [junit4] 2> 426765 T1027 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004\] [junit4] 2> 426766 T1027 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 426766 T1027 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 426766 T1027 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 426766 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 426766 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 426768 T1027 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 426768 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 426768 T1027 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 426769 T1027 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 426769 T1027 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 426775 T1027 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 426780 T1027 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 426781 T1027 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 426781 T1027 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 426781 T1027 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:59584/solr [junit4] 2> 426781 T1027 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 426781 T1027 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 426785 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 426790 T1096 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@79eaf9d5 name:ZooKeeperConnection Watcher:127.0.0.1:59584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 426792 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 426792 T1027 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 426803 T1027 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 426806 T1098 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@49453ba8 name:ZooKeeperConnection Watcher:127.0.0.1:59584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 426806 T1027 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 426824 T1027 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 427787 T1027 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59618_rhg%2Fze [junit4] 2> 427789 T1027 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:59618_rhg%2Fze [junit4] 2> 427815 T1027 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 427818 T1100 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 427818 T1100 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 427822 T1056 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 427823 T1100 oasc.ZkController.preRegister Registering watch for external collection collection1 [junit4] 2> 427824 T1100 oascc.ZkStateReader.addZkWatch addZkWatch collection1 [junit4] 2> 427824 T1100 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/collection1/state.json from ZooKeeper... [junit4] 2> 427828 T1100 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 4 [junit4] 2> 427828 T1100 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 427831 T1052 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:59618/rhg/ze";, [junit4] 2> "node_name":"127.0.0.1:59618_rhg%2Fze", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 427837 T1052 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4 [junit4] 2> 427839 T1052 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard3 [junit4] 2> 427856 T1052 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/collection1/state.json [junit4] 2> 427858 T1099 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 427860 T1099 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5 [junit4] 2> 427860 T1080 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json, has occurred - updating... [junit4] 2> 427864 T1080 oascc.ZkStateReader.updateWatchedCollection Updating data for collection1 to ver 5 [junit4] 2> 428780 T1100 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 428780 T1100 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 428781 T1100 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 428781 T1100 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 428783 T1100 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 428783 T1100 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004\collection1\' [junit4] 2> 428786 T1100 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-004/collection1/lib/.svn/' to classloader [junit4] 2> 428786 T1100 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-004/collection1/lib/classes/' to classloader [junit4] 2> 428786 T1100 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/build/solr-core/test/J0/temp/solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001/tempDir-004/collection1/lib/README' to classloader [junit4] 2> 428838 T1100 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 428891 T1100 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 428895 T1100 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 428903 T1100 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 429114 T1100 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 429116 T1100 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 429117 T1100 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 429124 T1100 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 429163 T1100 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 429164 T1100 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory [junit4] 2> 429164 T1100 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-004\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/jetty2\ [junit4] 2> 429164 T1100 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f7f2d93 [junit4] 2> 429166 T1100 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty2 [junit4] 2> 429167 T1100 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001/jetty2\index/ [junit4] 2> 429167 T1100 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty2\index' doesn't exist. Creating new index... [junit4] 2> 429170 T1100 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty2\index [junit4] 2> 429172 T1100 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=14.04296875, floorSegmentMB=0.40234375, forceMergeDeletesPctAllowed=26.924871955907822, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6098748653981755 [junit4] 2> 429180 T1100 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ShardRoutingTest-A34DE7C4D0639203-001\tempDir-001\jetty2\index,segFN=segments_1,generation=1} [junit4] 2> 429180 T1100 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 429185 T1100 oasup.UpdateRequestProcess [...truncated too long message...] at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-A34DE7C4D0639203-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=DefaultSimilarity, locale=ar_MA, timezone=Antarctica/Macquarie [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_20 (64-bit)/cpus=2,threads=1,free=112572264,total=494927872 [junit4] 2> NOTE: All tests run in this JVM: [TermVectorComponentDistributedTest, IndexSchemaRuntimeFieldTest, TestSolrDeletionPolicy2, TestSolrXmlPersistence, TestDocBasedVersionConstraints, ClusterStateUpdateTest, AsyncMigrateRouteKeyTest, HdfsBasicDistributedZk2Test, TestFieldTypeCollectionResource, HdfsWriteToMultipleCollectionsTest, UniqFieldsUpdateProcessorFactoryTest, BadComponentTest, SimplePostToolTest, CSVRequestHandlerTest, TestFieldSortValues, DistributedFacetPivotLargeTest, TestFiltering, TestSchemaNameResource, TestPivotHelperCode, TestDFRSimilarityFactory, TestXIncludeConfig, SolrPluginUtilsTest, HdfsRecoveryZkTest, SliceStateTest, TestStandardQParsers, AssignTest, TestCSVResponseWriter, DistributedTermsComponentTest, HdfsUnloadDistributedZkTest, BinaryUpdateRequestHandlerTest, AnalyticsMergeStrategyTest, TestInfoStreamLogging, PrimUtilsTest, SpellCheckComponentTest, SuggesterTSTTest, TestCoreContainer, StatelessScriptUpdateProcessorFactoryTest, URLClassifyProcessorTest, ChaosMonkeySafeLeaderTest, OutputWriterTest, ShardRoutingTest, TestUniqueKeyFieldResource, SolrIndexSplitterTest, OverriddenZkACLAndCredentialsProvidersTest, ReplicationFactorTest, HdfsLockFactoryTest, TestSearcherReuse, TestTrie, SolrRequestParserTest, PeerSyncTest, StandardRequestHandlerTest, DateRangeFieldTest, PreAnalyzedFieldTest, TestManagedResourceStorage, TestCSVLoader, PreAnalyzedUpdateProcessorTest, TestSurroundQueryParser, TestSerializedLuceneMatchVersion, TestSchemaVersionResource, TestManagedStopFilterFactory, TestSolrXmlPersistor, InfoHandlerTest, TestDistributedGrouping, TestSuggestSpellingConverter, SystemInfoHandlerTest, TestSolrQueryParser, SignatureUpdateProcessorFactoryTest, DirectUpdateHandlerOptimizeTest, SoftAutoCommitTest, RankQueryTest, IndexBasedSpellCheckerTest, DistributedSpellCheckComponentTest, XmlUpdateRequestHandlerTest, TestHighFrequencyDictionaryFactory, TestQueryUtils, ExitableDirectoryReaderTest, ParsingFieldUpdateProcessorsTest, AddSchemaFieldsUpdateProcessorFactoryTest, OverseerTest, TestPseudoReturnFields, TestBinaryResponseWriter, TestHashPartitioner, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestOverriddenPrefixQueryForCustomFieldType, TestShortCircuitedRequests, TestNRTOpen, BlockDirectoryTest, BasicFunctionalityTest, TestSchemaResource, TimeZoneUtilsTest, CloudExitableDirectoryReaderTest, EchoParamsTest, ChaosMonkeyNothingIsSafeTest, SpellingQueryConverterTest, DistributedQueryElevationComponentTest, DocValuesMultiTest, TestSolrDeletionPolicy1, ConnectionManagerTest, TestWordDelimiterFilterFactory, TriLevelCompositeIdRoutingTest, TestElisionMultitermQuery, TestRealTimeGet, SampleTest, TestDistributedSearch, RequiredFieldsTest, DistributedQueryComponentOptimizationTest, UnloadDistributedZkTest, LeaderElectionTest, TestRequestStatusCollectionAPI, TestCharFilters, ExternalFileFieldSortTest, TestFieldCollectionResource, TestNoOpRegenerator, CursorMarkTest, SuggesterFSTTest, TestLMDirichletSimilarityFactory, RAMDirectoryFactoryTest, DateFieldTest, LeaderFailoverAfterPartitionTest, DocumentAnalysisRequestHandlerTest, LukeRequestHandlerTest, MultiThreadedOCPTest, PolyFieldTest, TestCloudSchemaless, ShowFileRequestHandlerTest, ZkControllerTest, QueryElevationComponentTest, TestDocSet, DistributedQueryComponentCustomSortTest, ShardSplitTest, VMParamsZkACLAndCredentialsProvidersTest, TestSimpleQParserPlugin, TestHighlightDedupGrouping, SolrIndexConfigTest, SolrInfoMBeanTest, TestGroupingSearch, DistributedExpandComponentTest, OpenCloseCoreStressTest, TestSchemaSimilarityResource, TestStressLucene, MoreLikeThisHandlerTest, TestExpandComponent, SharedFSAutoReplicaFailoverTest, TestCollapseQParserPlugin, TestRTGBase, TestAtomicUpdateErrorCases, JsonLoaderTest, SimpleFacetsTest, AliasIntegrationTest, TestJmxIntegration, TestCodecSupport, TermsComponentTest, ZkNodePropsTest, TestBadConfig, ResponseLogComponentTest, CurrencyFieldOpenExchangeTest, DirectUpdateHandlerTest, OverseerCollectionProcessorTest, QueryParsingTest, TestClassNameShortening, TestReplicationHandlerBackup, TestSolrXml, DisMaxRequestHandlerTest, QueryEqualityTest, TestDistribDocBasedVersion, FieldMutatingUpdateProcessorTest, TestBulkSchemaAPI, CoreAdminRequestStatusTest, TestSchemaManager, TestShardHandlerFactory, TestBlendedInfixSuggestions, ZkCLITest, TestSolrIndexConfig, TestQuerySenderListener, AnalyticsQueryTest, TestReplicaProperties, CoreAdminCreateDiscoverTest, SharedFSAutoReplicaFailoverUtilsTest, AtomicUpdatesTest, XsltUpdateRequestHandlerTest, TestMiniSolrCloudCluster, BadCopyFieldTest, SortByFunctionTest, DeleteInactiveReplicaTest, TestManagedResource, TestBinaryField, MergeStrategyTest, BJQParserTest, TestSolr4Spatial, DOMUtilTest, TestNonDefinedSimilarityFactory, SolrTestCaseJ4Test, TestFastOutputStream, TestComponentsName, OutOfBoxZkACLAndCredentialsProvidersTest, SSLMigrationTest, TestSortingResponseWriter, RecoveryZkTest, TestFreeTextSuggestions, DateMathParserTest, TestRemoteStreaming, SolrCmdDistributorTest, TestPostingsSolrHighlighter, PingRequestHandlerTest, DocValuesMissingTest, BadIndexSchemaTest, NumericFieldsTest, TestFaceting, TestChildDocTransformer, BasicDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, TestRandomFaceting, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting, ShardRoutingCustomTest, AutoCommitTest, TestRecovery, TestStressReorder, TestJoin, TestMultiCoreConfBootstrap, TestReload, TestStressVersions, HardAutoCommitTest, TestRangeQuery, SolrCoreTest, StatsComponentTest, ConvertedLegacyTest, TestSort, TestFunctionQuery, TestLazyCores, TestIndexSearcher, HighlighterTest, CurrencyFieldXmlFileTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, SpellCheckCollatorTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, DocValuesTest, SuggesterTest, SpatialFilterTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestUpdate, DefaultValueUpdateProcessorTest, DistanceFunctionTest, DebugComponentTest, CacheHeaderTest, TestWriterPerf, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, TestQueryTypes, PrimitiveFieldTypeTest, TestOmitPositions, FileBasedSpellCheckerTest, RequestHandlersTest, DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, TestIndexingPerformance, FieldAnalysisRequestHandlerTest, TestArbitraryIndexDir, FastVectorHighlighterTest, LoggingHandlerTest, RegexBoostProcessorTest, IndexSchemaTest, TestCollationField, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, JSONWriterTest, MBeansHandlerTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, SearchHandlerTest, CoreContainerCoreInitFailuresTest, TestLFUCache, HighlighterConfigTest, SOLR749Test, UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, CopyFieldTest, TestStressRecovery, TestMergePolicyConfig, MultiTermTest, TestSearchPerf, MinimalSchemaTest, TestConfig, TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions, SpellPossibilityIteratorTest, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestBM25SimilarityFactory, TestDefaultSimilarityFactory, TestFastWriter, LegacyHTMLStripCharFilterTest, TestJmxMonitoredMap, ResourceLoaderTest, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache, TestSystemIdResolver, ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils, TestDocumentBuilder, UUIDFieldTest, FileUtilsTest, CircularListTest, CursorPagingTest, DistributedIntervalFacetingTest, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestTolerantSearch, CollectionsAPIAsyncDistributedZkTest, CustomCollectionTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest] [junit4] Completed in 236.79s, 1 test, 1 error <<< FAILURES! [...truncated 277 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:524: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:472: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:189: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:496: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1360: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:962: There were test failures: 437 suites, 1795 tests, 3 errors, 53 ignored (30 assumptions) Total time: 160 minutes 1 second Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_20 -XX:+UseCompressedOops -XX:+UseG1GC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
