Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4284/ Java: 32bit/jdk1.8.0_40-ea-b09 -server -XX:+UseG1GC
1 tests failed. REGRESSION: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch Error Message: No live SolrServers available to handle this request:[https://127.0.0.1:57078/zts/l, https://127.0.0.1:57096/zts/l, https://127.0.0.1:57054/zts/l, https://127.0.0.1:57069/zts/l, https://127.0.0.1:57087/zts/l] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:57078/zts/l, https://127.0.0.1:57096/zts/l, https://127.0.0.1:57054/zts/l, https://127.0.0.1:57069/zts/l, https://127.0.0.1:57087/zts/l] at __randomizedtesting.SeedInfo.seed([6D0D567FA45DEB71:ECEBD867D3028B4D]: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.GeneratedMethodAccessor48.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) 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 Build Log: [...truncated 11230 lines...] [junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\init-core-data-001 [junit4] 2> 1989206 T5545 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (true) [junit4] 2> 1989210 T5545 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /zts/l [junit4] 2> 1989211 T5545 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 1989211 T5545 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1989214 T5546 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 1989340 T5545 oasc.ZkTestServer.run start zk server on port:57044 [junit4] 2> 1989340 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1989342 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1989347 T5552 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@16627d5 name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1989348 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1989348 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1989348 T5545 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 1989353 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1989360 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1989363 T5554 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8b8363 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1989364 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1989364 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1989364 T5545 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 1989372 T5545 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 1989375 T5545 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 1989376 T5545 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 1989378 T5545 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> 1989378 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 1989383 T5545 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml [junit4] 2> 1989383 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 1989387 T5545 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> 1989387 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1989391 T5545 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> 1989391 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 1989393 T5545 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> 1989393 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 1989397 T5545 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> 1989397 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 1989400 T5545 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> 1989400 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 1989403 T5545 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> 1989404 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 1989406 T5545 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> 1989406 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1989410 T5545 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> 1989410 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 1989414 T5545 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> 1989414 T5545 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 1989417 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1989424 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1989428 T5556 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9fceb8 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1989428 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1989428 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1991271 T5545 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1991283 T5545 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 1991329 T5545 oejs.AbstractConnector.doStart Started [email protected]:57054 [junit4] 2> 1991335 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 1991335 T5545 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1991337 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002 [junit4] 2> 1991337 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\' [junit4] 2> 1991379 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\solr.xml [junit4] 2> 1991393 T5545 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002 [junit4] 2> 1991394 T5545 oasc.CoreContainer.<init> New CoreContainer 19460784 [junit4] 2> 1991394 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\] [junit4] 2> 1991396 T5545 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1991396 T5545 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1991396 T5545 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1991398 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1991398 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1991398 T5545 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1991399 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1991399 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1991399 T5545 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1991400 T5545 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1991404 T5545 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 1991408 T5545 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1991408 T5545 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1991409 T5545 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 1991409 T5545 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57044/solr [junit4] 2> 1991410 T5545 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 1991410 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1991413 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1991416 T5567 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1bc9c48 name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1991416 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1991416 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1991422 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1991425 T5569 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@101b185 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1991426 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1991428 T5545 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 1991436 T5545 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 1991440 T5545 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 1991446 T5545 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 1991452 T5545 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 1991461 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 1991465 T5545 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57054_zts%2Fl [junit4] 2> 1991466 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57054_zts%2Fl [junit4] 2> 1991471 T5545 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 1991474 T5545 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 1991478 T5545 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 1991480 T5545 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:57054_zts%2Fl [junit4] 2> 1991480 T5545 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 1991485 T5545 oasc.Overseer.start Overseer (id=92667713735884804-127.0.0.1:57054_zts%2Fl-n_0000000000) starting [junit4] 2> 1991491 T5545 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 1991509 T5545 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 1991512 T5571 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 1991513 T5545 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 1991519 T5545 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 1991523 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 1991534 T5545 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002 [junit4] 2> 1991546 T5570 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 1992365 T5545 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\conf\ [junit4] 2> 1992520 T5545 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1992523 T5545 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 1992523 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1992538 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1992542 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1992545 T5575 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1d1d2d8 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1992545 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1992546 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1992549 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 1992557 T5545 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 1992557 T5545 oasc.AbstractFullDistribZkTestBase.createJettys Creating collection1 with stateFormat=2 [junit4] 2> 1992557 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1992560 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1992563 T5577 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10e6f1e name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1992563 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1992563 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1992568 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 1992579 T5570 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: collection1 [junit4] 2> 1992579 T5570 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2] [junit4] 2> 1992579 T5570 oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2 [junit4] 2> 1992588 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/collection1/state.json [junit4] 2> 1992594 T5578 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> 1992596 T5579 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> 1994528 T5545 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 1994530 T5545 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1994545 T5545 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 1994553 T5545 oejs.AbstractConnector.doStart Started [email protected]:57069 [junit4] 2> 1994558 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 1994559 T5545 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1994559 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003 [junit4] 2> 1994559 T5545 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003\' [junit4] 2> 1994598 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003\solr.xml [junit4] 2> 1994651 T5545 oasc.CorePropertiesLocator.<init> Config-defined core root directory: 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003 [junit4] 2> 1994651 T5545 oasc.CoreContainer.<init> New CoreContainer 14868665 [junit4] 2> 1994651 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003\] [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1994652 T5545 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1994654 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1994656 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1994656 T5545 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1994656 T5545 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1994663 T5545 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 1994667 T5545 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1994667 T5545 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1994667 T5545 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 1994669 T5545 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57044/solr [junit4] 2> 1994669 T5545 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 1994669 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1994673 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1994685 T5590 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@67fcd name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1994685 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1994685 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1994692 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1994698 T5592 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@793ff0 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1994698 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1994714 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 1995876 T5545 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57069_zts%2Fl [junit4] 2> 1995878 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57069_zts%2Fl [junit4] 2> 1995886 T5545 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 1995891 T5545 oasc.CorePropertiesLocator.discover Looking for core definitions underneath 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003 [junit4] 2> 1997137 T5545 oasc.CorePropertiesLocator.discoverUnder Found core conf in 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003\conf\ [junit4] 2> 1997358 T5545 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1997360 T5545 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 1997360 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1999001 T5545 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 1999003 T5545 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1999012 T5545 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 1999015 T5545 oejs.AbstractConnector.doStart Started [email protected]:57078 [junit4] 2> 1999020 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 1999020 T5545 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1999021 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004 [junit4] 2> 1999021 T5545 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\' [junit4] 2> 1999060 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\solr.xml [junit4] 2> 1999073 T5545 oasc.CorePropertiesLocator.<init> Config-defined core root directory: 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004 [junit4] 2> 1999074 T5545 oasc.CoreContainer.<init> New CoreContainer 5862857 [junit4] 2> 1999074 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\] [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1999075 T5545 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1999078 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1999078 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1999078 T5545 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1999079 T5545 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1999082 T5545 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 1999085 T5545 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1999086 T5545 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1999086 T5545 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 1999086 T5545 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57044/solr [junit4] 2> 1999087 T5545 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 1999087 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 1999090 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1999093 T5605 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1c0384a name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1999094 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1999094 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 1999098 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 1999103 T5607 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@19b3b6b name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1999103 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 1999116 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2000242 T5545 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57078_zts%2Fl [junit4] 2> 2000243 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57078_zts%2Fl [junit4] 2> 2000252 T5545 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2000257 T5545 oasc.CorePropertiesLocator.discover Looking for core definitions underneath 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004 [junit4] 2> 2001514 T5545 oasc.CorePropertiesLocator.discoverUnder Found core conf in 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\conf\ [junit4] 2> 2001741 T5545 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2001743 T5545 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2001743 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2003538 T5545 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3 [junit4] 2> 2003539 T5545 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2003549 T5545 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2003552 T5545 oejs.AbstractConnector.doStart Started [email protected]:57087 [junit4] 2> 2003557 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 2003558 T5545 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2003558 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005 [junit4] 2> 2003559 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005\' [junit4] 2> 2003595 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005\solr.xml [junit4] 2> 2003607 T5545 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005 [junit4] 2> 2003608 T5545 oasc.CoreContainer.<init> New CoreContainer 32032602 [junit4] 2> 2003608 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005\] [junit4] 2> 2003609 T5545 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2003609 T5545 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2003610 T5545 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2003610 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2003610 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 2003611 T5545 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2003611 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2003611 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2003612 T5545 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2003612 T5545 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2003617 T5545 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 2003620 T5545 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2003620 T5545 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2003620 T5545 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2003621 T5545 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57044/solr [junit4] 2> 2003621 T5545 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2003622 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2003624 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2003627 T5620 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b622ea name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2003627 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2003627 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2003633 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2003636 T5622 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@76fb17 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2003637 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2003651 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2004778 T5545 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57087_zts%2Fl [junit4] 2> 2004780 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57087_zts%2Fl [junit4] 2> 2004789 T5545 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2004792 T5545 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005 [junit4] 2> 2005498 T5545 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005\conf\ [junit4] 2> 2005625 T5545 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2005630 T5545 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2005630 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2007230 T5545 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 4 [junit4] 2> 2007236 T5545 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2007247 T5545 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2007250 T5545 oejs.AbstractConnector.doStart Started [email protected]:57096 [junit4] 2> 2007252 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 2007252 T5545 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2007252 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006 [junit4] 2> 2007252 T5545 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006\' [junit4] 2> 2007285 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006\solr.xml [junit4] 2> 2007297 T5545 oasc.CorePropertiesLocator.<init> Config-defined core root directory: 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006 [junit4] 2> 2007298 T5545 oasc.CoreContainer.<init> New CoreContainer 24244231 [junit4] 2> 2007302 T5545 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006\] [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 2007302 T5545 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 2007304 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 2007304 T5545 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 2007304 T5545 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 2007304 T5545 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 2007307 T5545 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 2007310 T5545 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2007310 T5545 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2007310 T5545 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 2007310 T5545 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57044/solr [junit4] 2> 2007310 T5545 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 2007312 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2007315 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2007318 T5635 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@63ee6d name:ZooKeeperConnection Watcher:127.0.0.1:57044 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2007318 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2007318 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2007321 T5547 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14938cb6f60000d, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 2007323 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2007326 T5637 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1bfcd03 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2007326 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2007337 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2008351 T5545 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57096_zts%2Fl [junit4] 2> 2008352 T5545 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57096_zts%2Fl [junit4] 2> 2008360 T5545 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 2008365 T5545 oasc.CorePropertiesLocator.discover Looking for core definitions underneath 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006 [junit4] 2> 2009460 T5545 oasc.CorePropertiesLocator.discoverUnder Found core conf in 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-006\conf\ [junit4] 2> 2009677 T5545 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2009679 T5545 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2009679 T5545 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2009695 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2009697 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2009700 T5641 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7491ce name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2009700 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2009700 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2009703 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2009709 T5545 oasc.AbstractFullDistribZkTestBase.createCollection Creating collection with stateFormat=2: delLiveColl [junit4] 2> 2009709 T5545 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 2009713 T5545 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 2009715 T5643 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e2b3e3 name:ZooKeeperConnection Watcher:127.0.0.1:57044/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2009715 T5545 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 2009715 T5545 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 2009718 T5545 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 2009822 T5562 oasha.CollectionsHandler.handleCreateAction Creating Collection : replicationFactor=2&maxShardsPerNode=2&name=delLiveColl&action=CREATE&numShards=2&stateFormat=2&wt=javabin&version=2 [junit4] 2> 2009824 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged [junit4] 2> 2009856 T5571 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{ [junit4] 2> "operation":"create", [junit4] 2> "fromApi":"true", [junit4] 2> "name":"delLiveColl", [junit4] 2> "replicationFactor":"2", [junit4] 2> "numShards":"2", [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "stateFormat":"2"} [junit4] 2> 2009907 T5644 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : create , { [junit4] 2> "operation":"create", [junit4] 2> "fromApi":"true", [junit4] 2> "name":"delLiveColl", [junit4] 2> "replicationFactor":"2", [junit4] 2> "numShards":"2", [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "stateFormat":"2"} [junit4] 2> 2009911 T5644 oasc.OverseerCollectionProcessor.createConfNode Only one config set found in zk - using it:conf1 [junit4] 2> 2009911 T5644 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/delLiveColl [junit4] 2> 2009913 T5644 oascc.SolrZkClient.makePath makePath: /collections/delLiveColl [junit4] 2> 2009921 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2009930 T5570 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: delLiveColl [junit4] 2> 2009930 T5570 oasc.Overseer$ClusterStateUpdater.createCollection Create collection delLiveColl with shards [shard1, shard2] [junit4] 2> 2009930 T5570 oasc.Overseer$ClusterStateUpdater.createCollection state version delLiveColl 2 [junit4] 2> 2009936 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection /collections/delLiveColl/state.json [junit4] 2> 2009938 T5638 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009938 T5579 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009939 T5608 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009941 T5578 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009942 T5623 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009943 T5593 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009944 T5646 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2009945 T5645 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5) [junit4] 2> 2010023 T5644 oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new collection delLiveColl, shardNames [shard1, shard2] , replicationFactor : 2 [junit4] 2> 2010023 T5644 oasc.OverseerCollectionProcessor.createCollection Creating shard delLiveColl_shard1_replica1 as part of slice shard1 of collection delLiveColl on 127.0.0.1:57087_zts%2Fl [junit4] 2> 2010026 T5644 oasc.OverseerCollectionProcessor.createCollection Creating shard delLiveColl_shard1_replica2 as part of slice shard1 of collection delLiveColl on 127.0.0.1:57054_zts%2Fl [junit4] 2> 2010037 T5644 oasc.OverseerCollectionProcessor.createCollection Creating shard delLiveColl_shard2_replica1 as part of slice shard2 of collection delLiveColl on 127.0.0.1:57069_zts%2Fl [junit4] 2> 2010045 T5644 oasc.OverseerCollectionProcessor.createCollection Creating shard delLiveColl_shard2_replica2 as part of slice shard2 of collection delLiveColl on 127.0.0.1:57078_zts%2Fl [junit4] 2> 2010182 T5560 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard1_replica2&action=CREATE&numShards=2&collection=delLiveColl&shard=shard1&wt=javabin&version=2 [junit4] 2> 2010222 T5618 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard1_replica1&action=CREATE&numShards=2&collection=delLiveColl&shard=shard1&wt=javabin&version=2 [junit4] 2> 2010325 T5584 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard2_replica1&action=CREATE&numShards=2&collection=delLiveColl&shard=shard2&wt=javabin&version=2 [junit4] 2> 2010341 T5560 oasc.ZkController.publish publishing core=delLiveColl_shard1_replica2 state=down collection=delLiveColl [junit4] 2> 2010348 T5603 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard2_replica2&action=CREATE&numShards=2&collection=delLiveColl&shard=shard2&wt=javabin&version=2 [junit4] 2> 2010349 T5584 oasc.ZkController.publish publishing core=delLiveColl_shard2_replica1 state=down collection=delLiveColl [junit4] 2> 2010348 T5618 oasc.ZkController.publish publishing core=delLiveColl_shard1_replica1 state=down collection=delLiveColl [junit4] 2> 2010352 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2010355 T5560 oasc.ZkController.preRegister Registering watch for external collection delLiveColl [junit4] 2> 2010356 T5560 oascc.ZkStateReader.addZkWatch addZkWatch delLiveColl [junit4] 2> 2010359 T5560 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/delLiveColl/state.json from ZooKeeper... [junit4] 2> 2010361 T5618 oasc.ZkController.preRegister Registering watch for external collection delLiveColl [junit4] 2> 2010362 T5618 oascc.ZkStateReader.addZkWatch addZkWatch delLiveColl [junit4] 2> 2010362 T5584 oasc.ZkController.preRegister Registering watch for external collection delLiveColl [junit4] 2> 2010363 T5584 oascc.ZkStateReader.addZkWatch addZkWatch delLiveColl [junit4] 2> 2010364 T5603 oasc.ZkController.publish publishing core=delLiveColl_shard2_replica2 state=down collection=delLiveColl [junit4] 2> 2010366 T5618 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/delLiveColl/state.json from ZooKeeper... [junit4] 2> 2010366 T5584 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/delLiveColl/state.json from ZooKeeper... [junit4] 2> 2010367 T5560 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 0 [junit4] 2> 2010368 T5560 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2010372 T5618 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 0 [junit4] 2> 2010372 T5618 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2010374 T5584 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 0 [junit4] 2> 2010374 T5584 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2010375 T5603 oasc.ZkController.preRegister Registering watch for external collection delLiveColl [junit4] 2> 2010375 T5603 oascc.ZkStateReader.addZkWatch addZkWatch delLiveColl [junit4] 2> 2010377 T5603 oascc.ZkStateReader.addZkWatch Updating collection state at /collections/delLiveColl/state.json from ZooKeeper... [junit4] 2> 2010381 T5603 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 0 [junit4] 2> 2010381 T5570 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 0 [junit4] 2> 2010381 T5603 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 2010382 T5570 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"delLiveColl_shard1_replica2", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57054/zts/l";, [junit4] 2> "node_name":"127.0.0.1:57054_zts%2Fl", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"delLiveColl", [junit4] 2> "operation":"state"} [junit4] 2> 2010388 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/delLiveColl/state.json [junit4] 2> 2010389 T5593 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010390 T5623 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010390 T5578 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010390 T5608 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010391 T5593 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 1 [junit4] 2> 2010392 T5623 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 1 [junit4] 2> 2010392 T5608 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 1 [junit4] 2> 2010397 T5578 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 1 [junit4] 2> 2010406 T5570 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 1 [junit4] 2> 2010406 T5570 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"delLiveColl_shard1_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57087/zts/l";, [junit4] 2> "node_name":"127.0.0.1:57087_zts%2Fl", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"delLiveColl", [junit4] 2> "operation":"state"} [junit4] 2> 2010413 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2010413 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/delLiveColl/state.json [junit4] 2> 2010415 T5578 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010415 T5593 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010416 T5623 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010416 T5608 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010418 T5623 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 2 [junit4] 2> 2010418 T5593 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 2 [junit4] 2> 2010419 T5608 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 2 [junit4] 2> 2010423 T5578 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 2 [junit4] 2> 2010432 T5570 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 2 [junit4] 2> 2010432 T5570 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"delLiveColl_shard2_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57069/zts/l";, [junit4] 2> "node_name":"127.0.0.1:57069_zts%2Fl", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"delLiveColl", [junit4] 2> "operation":"state"} [junit4] 2> 2010437 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2010438 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/delLiveColl/state.json [junit4] 2> 2010440 T5593 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010441 T5578 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010441 T5608 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010441 T5623 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010442 T5593 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 3 [junit4] 2> 2010444 T5608 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 3 [junit4] 2> 2010444 T5623 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 3 [junit4] 2> 2010448 T5578 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 3 [junit4] 2> 2010456 T5570 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 3 [junit4] 2> 2010457 T5570 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"delLiveColl_shard2_replica2", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57078/zts/l";, [junit4] 2> "node_name":"127.0.0.1:57078_zts%2Fl", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"delLiveColl", [junit4] 2> "operation":"state"} [junit4] 2> 2010461 T5578 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2010462 T5570 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/delLiveColl/state.json [junit4] 2> 2010463 T5593 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010464 T5608 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010465 T5623 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010465 T5578 oascc.ZkStateReader$7.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/delLiveColl/state.json, has occurred - updating... [junit4] 2> 2010466 T5608 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 4 [junit4] 2> 2010466 T5593 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 4 [junit4] 2> 2010467 T5623 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 4 [junit4] 2> 2010471 T5578 oascc.ZkStateReader.updateWatchedCollection Updating data for delLiveColl to ver 4 [junit4] 2> 2011374 T5560 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for delLiveColl_shard1_replica2 [junit4] 2> 2011374 T5560 oasc.ZkController.createCollectionZkNode Check for collection zkNode:delLiveColl [junit4] 2> 2011375 T5560 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2011375 T5560 oascc.ZkStateReader.readConfigName Load collection config from:/collections/delLiveColl [junit4] 2> 2011377 T5560 oascc.ZkStateReader.readConfigName path=/collections/delLiveColl configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2011377 T5560 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\' [junit4] 2> 2011378 T5618 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for delLiveColl_shard1_replica1 [junit4] 2> 2011378 T5618 oasc.ZkController.createCollectionZkNode Check for collection zkNode:delLiveColl [junit4] 2> 2011379 T5584 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for delLiveColl_shard2_replica1 [junit4] 2> 2011379 T5584 oasc.ZkController.createCollectionZkNode Check for collection zkNode:delLiveColl [junit4] 2> 2011381 T5618 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2011381 T5618 oascc.ZkStateReader.readConfigName Load collection config from:/collections/delLiveColl [junit4] 2> 2011382 T5584 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2011382 T5584 oascc.ZkStateReader.readConfigName Load collection config from:/collections/delLiveColl [junit4] 2> 2011386 T5618 oascc.ZkStateReader.readConfigName path=/collections/delLiveColl configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2011386 T5618 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-005\delLiveColl_shard1_replica1\' [junit4] 2> 2011388 T5584 oascc.ZkStateReader.readConfigName path=/collections/delLiveColl configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2011388 T5603 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for delLiveColl_shard2_replica2 [junit4] 2> 2011388 T5603 oasc.ZkController.createCollectionZkNode Check for collection zkNode:delLiveColl [junit4] 2> 2011388 T5584 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-003\delLiveColl_shard2_replica1\' [junit4] 2> 2011398 T5603 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 2011398 T5603 oascc.ZkStateReader.readConfigName Load collection config from:/collections/delLiveColl [junit4] 2> 2011406 T5603 oascc.ZkStateReader.readConfigName path=/collections/delLiveColl configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2011406 T5603 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\' [junit4] 2> 2011445 T5603 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 2011445 T5560 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 2011454 T5603 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2011456 T5560 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2011459 T5560 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2011464 T5560 oass.IndexSchema.readSchema [delLiveColl_shard1_replica2] Schema name=test [junit4] 2> 2011459 T5603 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2011472 T5603 oass.IndexSchema.readSchema [delLiveColl_shard2_replica2] Schema name=test [junit4] 2> 2011605 T5603 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2011611 T5603 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2011613 T5603 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2011649 T5618 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 2011658 T5618 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2011667 T5584 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 2011676 T5584 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2011682 T5618 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2011686 T5618 oass.IndexSchema.readSchema [delLiveColl_shard1_replica1] Schema name=test [junit4] 2> 2011700 T5560 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2011704 T5560 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2011705 T5560 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2011711 T5584 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 2011716 T5584 oass.IndexSchema.readSchema [delLiveColl_shard2_replica1] Schema name=test [junit4] 2> 2011808 T5618 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2011812 T5618 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2011814 T5618 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2011842 T5584 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2011846 T5584 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2011849 T5584 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2011861 T5603 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011865 T5560 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011870 T5603 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011874 T5560 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011878 T5603 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011883 T5560 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011886 T5603 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011886 T5603 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011886 T5603 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011888 T5618 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011891 T5560 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011891 T5560 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011891 T5560 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011894 T5603 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011894 T5603 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011894 T5603 oasc.CoreContainer.create Creating SolrCore 'delLiveColl_shard2_replica2' using configuration from collection delLiveColl [junit4] 2> 2011894 T5603 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2011895 T5603 oasc.SolrCore.<init> [delLiveColl_shard2_replica2] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\, dataDir=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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\data\ [junit4] 2> 2011895 T5603 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1754a71 [junit4] 2> 2011896 T5603 oasc.CachingDirectoryFactory.get return new directory for 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\data\ [junit4] 2> 2011896 T5603 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\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\data\index/ [junit4] 2> 2011896 T5603 oasc.SolrCore.initIndex WARN [delLiveColl_shard2_replica2] Solr index directory '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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\data\index' doesn't exist. Creating new index... [junit4] 2> 2011897 T5603 oasc.CachingDirectoryFactory.get return new directory for 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-004\delLiveColl_shard2_replica2\data\index [junit4] 2> 2011898 T5603 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=10.107421875, floorSegmentMB=1.435546875, forceMergeDeletesPctAllowed=15.341017517084998, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6945007506533891 [junit4] 2> 2011899 T5603 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-7b9518)),segFN=segments_1,generation=1} [junit4] 2> 2011899 T5603 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2011903 T5603 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2011903 T5603 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2011903 T5603 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2011904 T5603 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2011904 T5603 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2011904 T5603 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2011905 T5603 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2011905 T5603 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2011905 T5603 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2011906 T5603 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2011906 T5603 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2011907 T5603 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 2011907 T5603 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 2011907 T5603 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 2011907 T5603 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 2011907 T5603 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 2011909 T5603 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 2011909 T5603 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 2011909 T5603 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 2011910 T5603 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 2011917 T5603 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2011919 T5603 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2011920 T5603 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2011920 T5618 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2011922 T5560 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011922 T5560 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011922 T5560 oasc.CoreContainer.create Creating SolrCore 'delLiveColl_shard1_replica2' using configuration from collection delLiveColl [junit4] 2> 2011923 T5560 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2011923 T5560 oasc.SolrCore.<init> [delLiveColl_shard1_replica2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\data\ [junit4] 2> 2011923 T5603 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2011923 T5560 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1754a71 [junit4] 2> 2011924 T5560 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\data\ [junit4] 2> 2011926 T5618 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011927 T5560 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\data\index/ [junit4] 2> 2011927 T5560 oasc.SolrCore.initIndex WARN [delLiveColl_shard1_replica2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\data\index' doesn't exist. Creating new index... [junit4] 2> 2011928 T5560 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.DeleteReplicaTest-6D0D567FA45DEB71-001\tempDir-002\delLiveColl_shard1_replica2\data\index [junit4] 2> 2011929 T5560 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=10.107421875, floorSegmentMB=1.435546875, forceMergeDeletesPctAllowed=15.341017517084998, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6945007506533891 [junit4] 2> 2011930 T5618 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011930 T5618 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011930 T5618 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2011929 T5603 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2011931 T5560 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-2d6a0e)),segFN=segments_1,generation=1} [junit4] 2> 2011932 T5560 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2011931 T5603 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2011935 T5618 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2011935 T5618 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2011935 T5618 oasc.CoreContainer.create Creatin [...truncated too long message...] 2> 2202580 T5695 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2202587 T5697 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 2202594 T5697 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={ [junit4] 2> "core":"delLiveColl_shard1_replica1", [junit4] 2> "core_node_name":"core_node2", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57087/zts/l";, [junit4] 2> "node_name":"127.0.0.1:57087_zts%2Fl", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"delLiveColl", [junit4] 2> "operation":"state"} [junit4] 2> 2202603 T5695 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 2202604 T5697 oasc.Overseer$ClusterStateUpdater.updateZkStates going to update_collection /collections/delLiveColl/state.json [junit4] 2> 2202609 T5698 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 2207542 T5545 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 57096 [junit4] 2> 2207542 T5545 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=24244231 [junit4] 2> 2207546 T5545 oasc.Overseer.close Overseer (id=92667713735884814-127.0.0.1:57096_zts%2Fl-n_0000000004) closing [junit4] 2> 2207546 T5697 oasc.Overseer$ClusterStateUpdater.run Overseer Loop exiting : 127.0.0.1:57096_zts%2Fl [junit4] 2> 2207555 T5695 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK [junit4] 2> 2207575 T5545 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/zts/l,null} [junit4] 2> 2212560 T5545 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch [junit4] 2> 2212562 T5545 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:57044 57044 [junit4] 2> 2214817 T5546 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:57044 57044 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DeleteReplicaTest -Dtests.method=testDistribSearch -Dtests.seed=6D0D567FA45DEB71 -Dtests.slow=true -Dtests.locale=lv_LV -Dtests.timezone=Atlantic/Azores -Dtests.file.encoding=UTF-8 [junit4] ERROR 226s | DeleteReplicaTest.testDistribSearch <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:57078/zts/l, https://127.0.0.1:57096/zts/l, https://127.0.0.1:57054/zts/l, https://127.0.0.1:57069/zts/l, https://127.0.0.1:57087/zts/l] [junit4] > at __randomizedtesting.SeedInfo.seed([6D0D567FA45DEB71:ECEBD867D3028B4D]:0) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:333) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrServer.sendRequest(CloudSolrServer.java:1015) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrServer.requestWithRetryOnStaleState(CloudSolrServer.java:793) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:736) [junit4] > at org.apache.solr.cloud.DeleteReplicaTest.removeAndWaitForReplicaGone(DeleteReplicaTest.java:172) [junit4] > at org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:145) [junit4] > at org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:89) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Could not remove replica : delLiveColl/shard1/core_node1 [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:569) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrServer.doRequest(LBHttpSolrServer.java:354) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:313) [junit4] > ... 46 more [junit4] 2> 2214833 T5545 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-6D0D567FA45DEB71-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=DefaultSimilarity, locale=lv_LV, timezone=Atlantic/Azores [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=2,threads=1,free=152078896,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [ExternalFileFieldSortTest, TestBlendedInfixSuggestions, TestDynamicFieldResource, DirectSolrSpellCheckerTest, TestMergePolicyConfig, TestComponentsName, DirectUpdateHandlerOptimizeTest, TestBadConfig, TestSimpleQParserPlugin, CoreMergeIndexesAdminHandlerTest, CachingDirectoryFactoryTest, VMParamsZkACLAndCredentialsProvidersTest, TestHashPartitioner, TestQueryTypes, TestCollationFieldDocValues, TestCollectionAPI, TestWriterPerf, TestMaxScoreQueryParser, TestRandomDVFaceting, CSVRequestHandlerTest, HdfsChaosMonkeySafeLeaderTest, SharedFSAutoReplicaFailoverTest, TestClassNameShortening, UpdateParamsTest, AnalysisAfterCoreReloadTest, BadComponentTest, BasicDistributedZkTest, TestSchemaManager, FileBasedSpellCheckerTest, ClusterStateTest, DefaultValueUpdateProcessorTest, TestAnalyzeInfixSuggestions, DocValuesMultiTest, TestSerializedLuceneMatchVersion, TestReloadAndDeleteDocs, TestDistributedSearch, TestExtendedDismaxParser, TestSolr4Spatial2, TestInfoStreamLogging, NoCacheHeaderTest, TestDFRSimilarityFactory, DocumentAnalysisRequestHandlerTest, MultiThreadedOCPTest, JsonLoaderTest, TestCoreContainer, BlockDirectoryTest, StressHdfsTest, DistributedQueryComponentCustomSortTest, TestOrdValues, XsltUpdateRequestHandlerTest, QueryElevationComponentTest, OpenExchangeRatesOrgProviderTest, TestCloudPivotFacet, CollectionsAPIDistributedZkTest, InfoHandlerTest, TestHighlightDedupGrouping, AtomicUpdatesTest, UUIDUpdateProcessorFallbackTest, TestStressReorder, TestQueryUtils, TestValueSourceCache, TestStressVersions, CustomCollectionTest, HdfsUnloadDistributedZkTest, TestOverriddenPrefixQueryForCustomFieldType, SpellPossibilityIteratorTest, TestCoreDiscovery, TestRecovery, TestSuggestSpellingConverter, TestReplicaProperties, ChaosMonkeyNothingIsSafeTest, TestShortCircuitedRequests, CursorPagingTest, SOLR749Test, TestConfig, TestManagedResource, SuggesterTest, StandardRequestHandlerTest, SolrCoreTest, SolrCoreCheckLockOnStartupTest, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallTest, TestLMDirichletSimilarityFactory, TestSolr4Spatial, TestLazyCores, TestBinaryField, CopyFieldTest, TestRequestStatusCollectionAPI, HttpPartitionTest, TestCopyFieldCollectionResource, RollingRestartTest, DOMUtilTest, TestCodecSupport, AnalyticsQueryTest, UnloadDistributedZkTest, PolyFieldTest, SystemInfoHandlerTest, TestXIncludeConfig, BasicZkTest, TestBulkSchemaConcurrent, QueryResultKeyTest, SortByFunctionTest, TestSchemaVersionResource, UUIDFieldTest, TestQuerySenderNoQuery, TestChildDocTransformer, TestShardHandlerFactory, TestReversedWildcardFilterFactory, TestStandardQParsers, OverseerCollectionProcessorTest, UpdateRequestProcessorFactoryTest, TestJmxMonitoredMap, RequiredFieldsTest, MinimalSchemaTest, TestSystemIdResolver, DeleteInactiveReplicaTest, ShardRoutingCustomTest, TestManagedSchemaDynamicFieldResource, OutputWriterTest, HdfsBasicDistributedZk2Test, ExitableDirectoryReaderTest, TestLeaderElectionZkExpiry, TestCollapseQParserPlugin, TestManagedStopFilterFactory, TestCharFilters, HdfsLockFactoryTest, TestJmxIntegration, HdfsBasicDistributedZkTest, NotRequiredUniqueKeyTest, CursorMarkTest, BadCopyFieldTest, DeleteReplicaTest] [junit4] Completed in 225.69s, 1 test, 1 error <<< FAILURES! [...truncated 964 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, 1797 tests, 1 error, 53 ignored (30 assumptions) Total time: 157 minutes 49 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b09 -server -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]
