You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/02/18 23:51:26 UTC
[JENKINS] Lucene-Solr-5.0-Linux (32bit/jdk1.8.0_40-ea-b22) - Build
# 161 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.0-Linux/161/
Java: 32bit/jdk1.8.0_40-ea-b22 -server -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.client.solrj.impl.CloudSolrClientTest.testDistribSearch
Error Message:
Error from server at http://127.0.0.1:53262/checkStateVerCol: STATE STALE: checkStateVerCol:26valid : false
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:53262/checkStateVerCol: STATE STALE: checkStateVerCol:26valid : false
at __randomizedtesting.SeedInfo.seed([33DBA822D1639648:B23D263AA63CF674]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:558)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:214)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:210)
at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:302)
at org.apache.solr.client.solrj.impl.CloudSolrClientTest.stateVersionParamTest(CloudSolrClientTest.java:422)
at org.apache.solr.client.solrj.impl.CloudSolrClientTest.doTest(CloudSolrClientTest.java:126)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:878)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java: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:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10969 lines...]
[junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientTest
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/init-core-data-001
[junit4] 2> 104783 T417 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 104783 T417 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 104785 T417 oasc.AbstractZkTestCase.<clinit> WARN TEST_HOME() does not exist - solrj test?
[junit4] 2> 104787 T417 oas.SolrTestCaseJ4.setUp ###Starting testWrongZkChrootTest
[junit4] 2> 104794 T417 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 104796 T418 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 104895 T417 oasc.ZkTestServer.run start zk server on port:59561
[junit4] 2> 104912 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 104966 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 104998 T425 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1c07b0b name:ZooKeeperConnection Watcher:127.0.0.1:59561 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 104999 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 104999 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 105002 T417 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 105024 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 105026 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 105028 T428 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@364097 name:ZooKeeperConnection Watcher:127.0.0.1:59561/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 105028 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 105028 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 105034 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 105037 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 105049 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 105050 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 105053 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 105054 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 105057 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 105058 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 105061 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml because it doesn't exist
[junit4] 2> 105061 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it doesn't exist
[junit4] 2> 105062 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it doesn't exist
[junit4] 2> 105062 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it doesn't exist
[junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because it doesn't exist
[junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json because it doesn't exist
[junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt because it doesn't exist
[junit4] 2> 105064 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because it doesn't exist
[junit4] 2> 105064 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it doesn't exist
[junit4] 2> 105069 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 105070 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 105071 T431 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1264d14 name:ZooKeeperConnection Watcher:127.0.0.1:59561/solr/xyz/foo got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 105072 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 105072 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 105073 T417 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 105091 T417 oas.SolrTestCaseJ4.tearDown ###Ending testWrongZkChrootTest
[junit4] 2> 105092 T417 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:59561 59561
[junit4] 2> 105796 T418 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:59561 59561
[junit4] 2> 105811 T417 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 105812 T417 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 105813 T432 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 105913 T417 oasc.ZkTestServer.run start zk server on port:35500
[junit4] 2> 105913 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 105914 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 105916 T439 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@846d7a name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 105917 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 105917 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 105917 T417 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 105921 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 105926 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 105928 T442 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1db12e5 name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 105928 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 105928 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 105929 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 105933 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 105936 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 105938 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 105946 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 105947 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 105953 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 105953 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml because it doesn't exist
[junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it doesn't exist
[junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it doesn't exist
[junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it doesn't exist
[junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because it doesn't exist
[junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json because it doesn't exist
[junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt because it doesn't exist
[junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because it doesn't exist
[junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it doesn't exist
[junit4] 2> 106110 T417 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores/collection1
[junit4] 2> 106112 T417 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 106115 T417 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:36913
[junit4] 2> 106116 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
[junit4] 2> 106116 T417 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 106117 T417 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001
[junit4] 2> 106117 T417 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/'
[junit4] 2> 106134 T417 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/solr.xml
[junit4] 2> 106141 T417 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores
[junit4] 2> 106141 T417 oasc.CoreContainer.<init> New CoreContainer 10037181
[junit4] 2> 106142 T417 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/]
[junit4] 2> 106142 T417 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 106143 T417 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 106143 T417 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 106146 T417 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 106146 T417 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 106147 T417 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 106147 T417 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 106148 T417 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 106148 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 106148 T417 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:35500/solr
[junit4] 2> 106164 T417 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 106165 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 106165 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 106176 T454 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@915c9a name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 106176 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 106177 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 106185 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 106196 T457 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@b547d5 name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 106196 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 106206 T417 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 106407 T417 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 106412 T417 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
[junit4] 2> 106415 T417 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
[junit4] 2> 106419 T417 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
[junit4] 2> 106427 T417 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 106429 T417 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36913_
[junit4] 2> 106431 T417 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:36913_
[junit4] 2> 106433 T417 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 106435 T417 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 106437 T417 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 106442 T417 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:36913_
[junit4] 2> 106442 T417 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 106444 T417 oasc.Overseer.start Overseer (id=93342907826307075-127.0.0.1:36913_-n_0000000000) starting
[junit4] 2> 106450 T417 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 106470 T417 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 106478 T459 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 106479 T417 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 106481 T417 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 106483 T417 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 106490 T458 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 106490 T417 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores
[junit4] 2> 106493 T417 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores/collection1/
[junit4] 2> 106493 T417 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 106495 T461 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection
[junit4] 2> 106495 T461 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 106500 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 106500 T461 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 106504 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 0, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36913",
[junit4] 2> "node_name":"127.0.0.1:36913_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 106517 T458 oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36913",
[junit4] 2> "node_name":"127.0.0.1:36913_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 106519 T458 oasco.ClusterStateMutator.createCollection building a new cName: control_collection
[junit4] 2> 106530 T458 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 106536 T457 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> 107501 T461 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 107501 T461 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4] 2> 107502 T461 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 107502 T461 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 107503 T461 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 107503 T461 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores/collection1/'
[junit4] 2> 107515 T461 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 107518 T461 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 107522 T461 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 107525 T461 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 107536 T461 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 107537 T461 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 107544 T461 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 107667 T461 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 107668 T461 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 107668 T461 oass.IndexSchema.loadCopyFields WARN Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 107669 T461 oass.IndexSchema.loadCopyFields WARN Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 107671 T461 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection
[junit4] 2> 107671 T461 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 107672 T461 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-001/cores/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data/
[junit4] 2> 107672 T461 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 107672 T461 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data
[junit4] 2> 107672 T461 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data/index/
[junit4] 2> 107673 T461 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 107673 T461 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data/index
[junit4] 2> 107674 T461 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1fcf0b2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@296d3b),segFN=segments_1,generation=1}
[junit4] 2> 107674 T461 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 107674 T461 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 107680 T461 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 107681 T461 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 107681 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 107683 T461 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4] 2> 107684 T461 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 107685 T461 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 107686 T461 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 107686 T461 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 107687 T461 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 107687 T461 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 107688 T461 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 107688 T461 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1fcf0b2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@296d3b),segFN=segments_1,generation=1}
[junit4] 2> 107688 T461 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 107689 T461 oass.SolrIndexSearcher.<init> Opening Searcher@7ab1a8[collection1] main
[junit4] 2> 107689 T461 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 107690 T461 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 107690 T461 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 107692 T461 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 107692 T461 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 107692 T461 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 107693 T461 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 107693 T461 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 107693 T461 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 107693 T461 oasha.AdminHandlers.inform WARN <requestHandler name="/admin/"
[junit4] 2> class="solr.admin.AdminHandlers" /> is deprecated . It is not required anymore
[junit4] 2> 107694 T462 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7ab1a8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 107695 T461 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 107695 T465 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:36913 collection:control_collection shard:shard1
[junit4] 2> 107696 T417 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0
[junit4] 2> 107696 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 107697 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 107697 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 107699 T468 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@127ae07 name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 107699 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 107699 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 107702 T417 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 107706 T417 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 107710 T465 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 107735 T465 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 107737 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 107738 T465 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 107738 T465 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C329 name=collection1 org.apache.solr.core.SolrCore@44efd0 url=http://127.0.0.1:36913/collection1 node=127.0.0.1:36913_ C329_STATE=coll:control_collection core:collection1 props:{core=collection1, base_url=http://127.0.0.1:36913, node_name=127.0.0.1:36913_, state=down}
[junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:36913/collection1/
[junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.syncToMe http://127.0.0.1:36913/collection1/ has no replicas
[junit4] 2> 107741 T465 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:36913/collection1/ shard1
[junit4] 2> 107743 T465 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 107743 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 107751 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 107764 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:36913",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 107805 T417 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores/collection1
[junit4] 2> 107806 T417 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
[junit4] 2> 107807 T417 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 107811 T417 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:56075
[junit4] 2> 107812 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
[junit4] 2> 107812 T417 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 107812 T417 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001
[junit4] 2> 107813 T417 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/'
[junit4] 2> 107823 T417 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/solr.xml
[junit4] 2> 107828 T417 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores
[junit4] 2> 107828 T417 oasc.CoreContainer.<init> New CoreContainer 32563491
[junit4] 2> 107829 T417 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/]
[junit4] 2> 107829 T417 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 107829 T417 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 107832 T417 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 107832 T417 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 107832 T417 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 107833 T417 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 107833 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 107833 T417 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:35500/solr
[junit4] 2> 107833 T417 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 107834 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 107834 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 107836 T480 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@df0348 name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 107837 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 107837 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 107839 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 107841 T483 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@75271e name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 107841 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 107847 T417 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 107867 T483 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> 107867 T457 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> 107867 T468 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> 107914 T465 oasc.ZkController.register We are http://127.0.0.1:36913/collection1/ and leader is http://127.0.0.1:36913/collection1/
[junit4] 2> 107914 T465 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:36913
[junit4] 2> 107914 T465 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 107915 T465 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection
[junit4] 2> 107915 T465 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 107916 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 107923 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36913",
[junit4] 2> "node_name":"127.0.0.1:36913_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 107924 T458 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36913",
[junit4] 2> "node_name":"127.0.0.1:36913_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 108027 T468 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> 108027 T483 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> 108028 T457 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> 108850 T417 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56075_
[junit4] 2> 108851 T417 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:56075_
[junit4] 2> 108855 T417 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 108858 T417 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores
[junit4] 2> 108859 T417 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores/collection1/
[junit4] 2> 108859 T417 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 108860 T484 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1
[junit4] 2> 108860 T484 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 108861 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 108861 T484 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 108862 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:56075",
[junit4] 2> "node_name":"127.0.0.1:56075_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 108863 T458 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:56075",
[junit4] 2> "node_name":"127.0.0.1:56075_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 108863 T458 oasco.ClusterStateMutator.createCollection building a new cName: collection1
[junit4] 2> 108863 T458 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard2
[junit4] 2> 108967 T468 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 108967 T457 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 108967 T483 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 109862 T484 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 109862 T484 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 109863 T484 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 109863 T484 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 109864 T484 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 109864 T484 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores/collection1/'
[junit4] 2> 109874 T484 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 109876 T484 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 109879 T484 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 109888 T484 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 109895 T484 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 109901 T484 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 109905 T484 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 109996 T484 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 109998 T484 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 109999 T484 oass.IndexSchema.loadCopyFields WARN Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 110002 T484 oass.IndexSchema.loadCopyFields WARN Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 110002 T484 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 110003 T484 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 110003 T484 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-001/cores/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1/
[junit4] 2> 110003 T484 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 110003 T484 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1
[junit4] 2> 110004 T484 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1/index/
[junit4] 2> 110004 T484 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1/index' doesn't exist. Creating new index...
[junit4] 2> 110004 T484 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1/index
[junit4] 2> 110004 T484 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@b4a931 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d1df76),segFN=segments_1,generation=1}
[junit4] 2> 110005 T484 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 110005 T484 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 110005 T484 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 110009 T484 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 110010 T484 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 110010 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 110010 T484 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4] 2> 110011 T484 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 110012 T484 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 110013 T484 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 110013 T484 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 110014 T484 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 110014 T484 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 110014 T484 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 110015 T484 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@b4a931 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d1df76),segFN=segments_1,generation=1}
[junit4] 2> 110015 T484 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 110015 T484 oass.SolrIndexSearcher.<init> Opening Searcher@a60e3b[collection1] main
[junit4] 2> 110015 T484 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 110019 T484 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 110020 T484 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 110020 T484 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 110020 T484 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 110020 T484 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 110021 T484 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 110021 T484 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 110021 T484 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 110021 T484 oasha.AdminHandlers.inform WARN <requestHandler name="/admin/"
[junit4] 2> class="solr.admin.AdminHandlers" /> is deprecated . It is not required anymore
[junit4] 2> 110022 T484 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 110022 T488 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:56075 collection:collection1 shard:shard2
[junit4] 2> 110023 T485 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a60e3b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 110024 T417 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0
[junit4] 2> 110024 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 110030 T488 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4] 2> 110034 T488 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2
[junit4] 2> 110036 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 110036 T488 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 110036 T488 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C330 name=collection1 org.apache.solr.core.SolrCore@45b641 url=http://127.0.0.1:56075/collection1 node=127.0.0.1:56075_ C330_STATE=coll:collection1 core:collection1 props:{core=collection1, base_url=http://127.0.0.1:56075, node_name=127.0.0.1:56075_, state=down}
[junit4] 2> 110036 T488 C330 P56075 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:56075/collection1/
[junit4] 2> 110037 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1"} current state version: 4
[junit4] 2> 110037 T488 C330 P56075 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 110037 T488 C330 P56075 oasc.SyncStrategy.syncToMe http://127.0.0.1:56075/collection1/ has no replicas
[junit4] 2> 110038 T488 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:56075/collection1/ shard2
[junit4] 2> 110038 T488 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4] 2> 110042 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 110043 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:56075",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 4
[junit4] 2> 110146 T468 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110146 T483 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110146 T457 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110155 T417 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores/collection1
[junit4] 2> 110157 T417 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
[junit4] 2> 110157 T417 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 110160 T417 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:53262
[junit4] 2> 110160 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
[junit4] 2> 110161 T417 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 110161 T417 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001
[junit4] 2> 110161 T417 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/'
[junit4] 2> 110178 T417 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/solr.xml
[junit4] 2> 110184 T417 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores
[junit4] 2> 110185 T417 oasc.CoreContainer.<init> New CoreContainer 5595126
[junit4] 2> 110185 T417 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/]
[junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 110189 T417 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 110189 T417 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false
[junit4] 2> 110190 T417 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 110190 T417 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 110191 T417 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 110191 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 110191 T417 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:35500/solr
[junit4] 2> 110192 T417 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 110192 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 110193 T488 oasc.ZkController.register We are http://127.0.0.1:56075/collection1/ and leader is http://127.0.0.1:56075/collection1/
[junit4] 2> 110193 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 110194 T488 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:56075
[junit4] 2> 110194 T488 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 110194 T488 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1
[junit4] 2> 110195 T488 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 110195 T500 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@11e784e name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110196 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 110196 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 110196 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 110197 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:56075",
[junit4] 2> "node_name":"127.0.0.1:56075_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 110199 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 110202 T458 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:56075",
[junit4] 2> "node_name":"127.0.0.1:56075_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 110203 T503 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5201fc name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 110203 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 110214 T417 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 110308 T468 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110308 T483 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110308 T457 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 110308 T503 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 111218 T417 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53262_
[junit4] 2> 111219 T417 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:53262_
[junit4] 2> 111222 T417 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 111224 T417 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores
[junit4] 2> 111225 T417 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores/collection1/
[junit4] 2> 111225 T417 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 111226 T504 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1
[junit4] 2> 111226 T504 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 111227 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 111227 T504 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 111228 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53262",
[junit4] 2> "node_name":"127.0.0.1:53262_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 6
[junit4] 2> 111228 T458 oasco.ReplicaMutator.updateState Update state numShards=2 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53262",
[junit4] 2> "node_name":"127.0.0.1:53262_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 111229 T458 oasco.ReplicaMutator.updateState Collection already exists with numShards=2
[junit4] 2> 111229 T458 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 111331 T483 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 111332 T503 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 111332 T457 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 111331 T468 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 112228 T504 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 112228 T504 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 112229 T504 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 112229 T504 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 112229 T504 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 112229 T504 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores/collection1/'
[junit4] 2> 112244 T504 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1
[junit4] 2> 112246 T504 oasc.Config.<init> loaded config solrconfig.xml with version 0
[junit4] 2> 112250 T504 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 112254 T504 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 112268 T504 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 112269 T504 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 112272 T504 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 112355 T504 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 112363 T504 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 112364 T504 oass.IndexSchema.loadCopyFields WARN Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 112364 T504 oass.IndexSchema.loadCopyFields WARN Field text is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 112365 T504 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 112365 T504 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 112365 T504 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-001/cores/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty2/
[junit4] 2> 112365 T504 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 112366 T504 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty2
[junit4] 2> 112366 T504 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty2/index/
[junit4] 2> 112366 T504 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty2/index' doesn't exist. Creating new index...
[junit4] 2> 112366 T504 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty2/index
[junit4] 2> 112367 T504 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@552434 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38a39a),segFN=segments_1,generation=1}
[junit4] 2> 112367 T504 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 112367 T504 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 112368 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 112369 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 112370 T504 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 112370 T504 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 112371 T504 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers]. Please consult documentation how to replace it accordingly.
[junit4] 2> 112371 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 112371 T504 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4] 2> 112372 T504 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 112373 T504 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 112373 T504 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 112374 T504 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 112374 T504 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 112375 T504 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 112375 T504 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 112375 T504 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@552434 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38a39a),segFN=segments_1,generation=1}
[junit4] 2> 112376 T504 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 112376 T504 oass.SolrIndexSearcher.<init> Opening Searcher@1bc83d4[collection1] main
[junit4] 2> 112376 T504 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 112377 T504 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 112377 T504 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 112377 T504 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 112378 T504 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 112378 T504 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 112378 T504 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 112378 T504 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 112379 T504 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 112379 T504 oasha.AdminHandlers.inform WARN <requestHandler name="/admin/"
[junit4] 2> class="solr.admin.AdminHandlers" /> is deprecated . It is not required anymore
[junit4] 2> 112379 T505 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1bc83d4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 112379 T504 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 112380 T508 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:53262 collection:collection1 shard:shard1
[junit4] 2> 112380 T417 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0
[junit4] 2> 112381 T508 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4] 2> 112381 T417 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 112384 T508 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 112386 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 112386 T508 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 112387 T508 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> 112387 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1"} current state version: 7
[junit4] 2> ASYNC NEW_CORE C331 name=collection1 org.apache.solr.core.SolrCore@16c4d67 url=http://127.0.0.1:53262/collection1 node=127.0.0.1:53262_ C331_STATE=coll:collection1 core:collection1 props:{core=collection1, base_url=http://127.0.0.1:53262, node_name=127.0.0.1:53262_, state=down}
[junit4] 2> 112387 T508 C331 P53262 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:53262/collection1/
[junit4] 2> 112387 T508 C331 P53262 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 112387 T508 C331 P53262 oasc.SyncStrategy.syncToMe http://127.0.0.1:53262/collection1/ has no replicas
[junit4] 2> 112388 T508 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:53262/collection1/ shard1
[junit4] 2> 112388 T508 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4] 2> 112396 T457 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 112397 T458 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard
[...truncated too long message...]
rClientTest.java:422)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClientTest.doTest(CloudSolrClientTest.java:126)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:878)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 134359 T417 oas.SolrTestCaseJ4.setUp ###Starting testShutdown
[junit4] 2> 134359 T417 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 134360 T613 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 134460 T417 oasc.ZkTestServer.run start zk server on port:50951
[junit4] 2> 134460 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 134461 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 134464 T620 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a364d3 name:ZooKeeperConnection Watcher:127.0.0.1:50951 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 134465 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 134465 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 134466 T417 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 134468 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 134470 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 134471 T623 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1c08a4 name:ZooKeeperConnection Watcher:127.0.0.1:50951/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 134472 T417 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 134472 T417 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
[junit4] 2> 134472 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 134474 T417 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 134475 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 134476 T417 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 134478 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 134478 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 134480 T417 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 134480 T417 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 134482 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml because it doesn't exist
[junit4] 2> 134482 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it doesn't exist
[junit4] 2> 134482 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it doesn't exist
[junit4] 2> 134483 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it doesn't exist
[junit4] 2> 134483 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because it doesn't exist
[junit4] 2> 134483 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json because it doesn't exist
[junit4] 2> 134483 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt because it doesn't exist
[junit4] 2> 134484 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because it doesn't exist
[junit4] 2> 134484 T417 oasc.AbstractZkTestCase.putConfig skipping /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it doesn't exist
[junit4] 2> 134485 T417 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
[junit4] 2> 134493 T417 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 134496 T624 oaz.ClientCnxnSocketNIO.connect ERROR Unable to open socket to ff01::114/ff01:0:0:0:0:0:0:114:33332
[junit4] 2> 134496 T624 oaz.ClientCnxn$SendThread.run WARN Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect java.net.SocketException: Network is unreachable
[junit4] 2> at sun.nio.ch.Net.connect0(Native Method)
[junit4] 2> at sun.nio.ch.Net.connect(Net.java:458)
[junit4] 2> at sun.nio.ch.Net.connect(Net.java:450)
[junit4] 2> at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:648)
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.registerAndConnect(ClientCnxnSocketNIO.java:277)
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.connect(ClientCnxnSocketNIO.java:287)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:967)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
[junit4] 2>
[junit4] 2> 135598 T624 oaz.ClientCnxnSocketNIO.connect ERROR Unable to open socket to ff01::114/ff01:0:0:0:0:0:0:114:33332
[junit4] 2> 135699 T417 oas.SolrTestCaseJ4.tearDown ###Ending testShutdown
[junit4] 2> 135700 T417 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:50951 50951
[junit4] 2> 136401 T613 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:50951 50951
[junit4] 2> 136404 T417 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {_version_=PostingsFormat(name=LuceneFixedGap), multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), a_t=PostingsFormat(name=LuceneFixedGap), intDefault=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=Direct), text=PostingsFormat(name=LuceneVarGapDocFreqInterval), range_facet_l=PostingsFormat(name=LuceneFixedGap), timestamp=PostingsFormat(name=LuceneFixedGap)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=in, timezone=America/St_Kitts
[junit4] 2> NOTE: Linux 3.13.0-45-generic i386/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=8,threads=1,free=34716760,total=78606336
[junit4] 2> NOTE: All tests run in this JVM: [SolrExampleStreamingTest, TestEmbeddedSolrServer, SolrExampleXMLTest, JettyWebappTest, TestXMLEscaping, TestCoreAdmin, DocumentAnalysisResponseTest, TermsResponseTest, TestJavaBinCodec, TestSolrProperties, FieldAnalysisResponseTest, TestLBHttpSolrClient, TestDocumentObjectBinder, NamedListTest, SolrExampleEmbeddedTest, TestBatchUpdate, LargeVolumeEmbeddedTest, TestSpellCheckResponse, MergeIndexesEmbeddedTest, QueryResponseTest, TestNamedListCodec, TestHash, ContentStreamTest, ModifiableSolrParamsTest, TestFastInputStream, SolrDocumentTest, SolrExceptionTest, TestUpdateRequestCodec, AnlysisResponseBaseTest, FacetFieldTest, SolrSchemalessExampleTest, BasicHttpSolrClientTest, CloudSolrClientMultiConstructorTest, CloudSolrClientTest]
[junit4] Completed on J0 in 31.65s, 3 tests, 1 error <<< FAILURES!
[...truncated 62 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/build.xml:529: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/build.xml:477: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/build.xml:204: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/common-build.xml:508: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/lucene/common-build.xml:1363: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/lucene/common-build.xml:970: There were test failures: 52 suites, 329 tests, 1 error
Total time: 76 minutes 34 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b22 -server -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Re: [JENKINS] Lucene-Solr-5.0-Linux (32bit/jdk1.8.0_40-ea-b22) -
Build # 161 - Failure!
Posted by Mark Miller <ma...@gmail.com>.
Error from server at http://127.0.0.1:53262/checkStateVerCol: STATE STALE:
checkStateVerCol:26valid : false
What does that even mean? Not a very good error.
- Mark
On Wed Feb 18 2015 at 5:52:24 PM Policeman Jenkins Server <
jenkins@thetaphi.de> wrote:
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.0-Linux/161/
> Java: 32bit/jdk1.8.0_40-ea-b22 -server -XX:+UseSerialGC
>
> 1 tests failed.
> FAILED: org.apache.solr.client.solrj.impl.CloudSolrClientTest.
> testDistribSearch
>
> Error Message:
> Error from server at http://127.0.0.1:53262/checkStateVerCol: STATE
> STALE: checkStateVerCol:26valid : false
>
> Stack Trace:
> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:
> Error from server at http://127.0.0.1:53262/checkStateVerCol: STATE
> STALE: checkStateVerCol:26valid : false
> at __randomizedtesting.SeedInfo.seed([33DBA822D1639648:
> B23D263AA63CF674]:0)
> at org.apache.solr.client.solrj.impl.HttpSolrClient.
> executeMethod(HttpSolrClient.java:558)
> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(
> HttpSolrClient.java:214)
> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(
> HttpSolrClient.java:210)
> at org.apache.solr.client.solrj.request.QueryRequest.process(
> QueryRequest.java:91)
> at org.apache.solr.client.solrj.SolrClient.query(SolrClient.
> java:302)
> at org.apache.solr.client.solrj.impl.CloudSolrClientTest.
> stateVersionParamTest(CloudSolrClientTest.java:422)
> at org.apache.solr.client.solrj.impl.CloudSolrClientTest.
> doTest(CloudSolrClientTest.java:126)
> at org.apache.solr.BaseDistributedSearchTestCase.
> testDistribSearch(BaseDistributedSearchTestCase.java:878)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(
> NativeMethodAccessorImpl.java:62)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(
> DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java: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:54)
> at org.apache.lucene.util.TestRuleMarkFailure$1.
> evaluate(TestRuleMarkFailure.java:48)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures
> $1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(
> TestRuleIgnoreTestSuites.java:55)
> at com.carrotsearch.randomizedtesting.rules.
> StatementAdapter.evaluate(StatementAdapter.java:36)
> at com.carrotsearch.randomizedtesting.ThreadLeakControl$
> StatementRunner.run(ThreadLeakControl.java:365)
> at java.lang.Thread.run(Thread.java:745)
>
>
>
>
> Build Log:
> [...truncated 10969 lines...]
> [junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientTest
> [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/init-
> core-data-001
> [junit4] 2> 104783 T417 oas.SolrTestCaseJ4.buildSSLConfig Randomized
> ssl (false) and clientAuth (false)
> [junit4] 2> 104783 T417 oas.BaseDistributedSearchTestCase.initHostContext
> Setting hostContext system property: /
> [junit4] 2> 104785 T417 oasc.AbstractZkTestCase.<clinit> WARN
> TEST_HOME() does not exist - solrj test?
> [junit4] 2> 104787 T417 oas.SolrTestCaseJ4.setUp ###Starting
> testWrongZkChrootTest
> [junit4] 2> 104794 T417 oasc.ZkTestServer.run STARTING ZK TEST SERVER
> [junit4] 1> client port:0.0.0.0/0.0.0.0:0
> [junit4] 2> 104796 T418 oasc.ZkTestServer$ZKServerMain.runFromConfig
> Starting server
> [junit4] 2> 104895 T417 oasc.ZkTestServer.run start zk server on
> port:59561
> [junit4] 2> 104912 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 104966 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 104998 T425 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@1c07b0b
> name:ZooKeeperConnection Watcher:127.0.0.1:59561 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 104999 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 104999 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 105002 T417 oascc.SolrZkClient.makePath makePath: /solr
> [junit4] 2> 105024 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 105026 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 105028 T428 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@364097
> name:ZooKeeperConnection Watcher:127.0.0.1:59561/solr got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 105028 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 105028 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 105034 T417 oascc.SolrZkClient.makePath makePath:
> /collections/collection1
> [junit4] 2> 105037 T417 oascc.SolrZkClient.makePath makePath:
> /collections/collection1/shards
> [junit4] 2> 105049 T417 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection
> [junit4] 2> 105050 T417 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection/shards
> [junit4] 2> 105053 T417 oasc.AbstractZkTestCase.putConfig put
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to
> /configs/conf1/solrconfig.xml
> [junit4] 2> 105054 T417 oascc.SolrZkClient.makePath makePath:
> /configs/conf1/solrconfig.xml
> [junit4] 2> 105057 T417 oasc.AbstractZkTestCase.putConfig put
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to
> /configs/conf1/schema.xml
> [junit4] 2> 105058 T417 oascc.SolrZkClient.makePath makePath:
> /configs/conf1/schema.xml
> [junit4] 2> 105061 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
> because it doesn't exist
> [junit4] 2> 105061 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it
> doesn't exist
> [junit4] 2> 105062 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it
> doesn't exist
> [junit4] 2> 105062 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it
> doesn't exist
> [junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because
> it doesn't exist
> [junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json
> because it doesn't exist
> [junit4] 2> 105063 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt
> because it doesn't exist
> [junit4] 2> 105064 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because
> it doesn't exist
> [junit4] 2> 105064 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it
> doesn't exist
> [junit4] 2> 105069 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 105070 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 105071 T431 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@1264d14
> name:ZooKeeperConnection Watcher:127.0.0.1:59561/solr/xyz/foo got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 105072 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 105072 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 105073 T417 oascc.SolrZkClient.makePath makePath:
> /clusterstate.json
> [junit4] 2> 105091 T417 oas.SolrTestCaseJ4.tearDown ###Ending
> testWrongZkChrootTest
> [junit4] 2> 105092 T417 oasc.ZkTestServer.send4LetterWord connecting
> to 127.0.0.1:59561 59561
> [junit4] 2> 105796 T418 oasc.ZkTestServer.send4LetterWord connecting
> to 127.0.0.1:59561 59561
> [junit4] 2> 105811 T417 oas.SolrTestCaseJ4.setUp ###Starting
> testDistribSearch
> [junit4] 2> 105812 T417 oasc.ZkTestServer.run STARTING ZK TEST SERVER
> [junit4] 1> client port:0.0.0.0/0.0.0.0:0
> [junit4] 2> 105813 T432 oasc.ZkTestServer$ZKServerMain.runFromConfig
> Starting server
> [junit4] 2> 105913 T417 oasc.ZkTestServer.run start zk server on
> port:35500
> [junit4] 2> 105913 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 105914 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 105916 T439 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@846d7a
> name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 105917 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 105917 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 105917 T417 oascc.SolrZkClient.makePath makePath: /solr
> [junit4] 2> 105921 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 105926 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 105928 T442 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@1db12e5
> name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 105928 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 105928 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 105929 T417 oascc.SolrZkClient.makePath makePath:
> /collections/collection1
> [junit4] 2> 105933 T417 oascc.SolrZkClient.makePath makePath:
> /collections/collection1/shards
> [junit4] 2> 105936 T417 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection
> [junit4] 2> 105938 T417 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection/shards
> [junit4] 2> 105946 T417 oasc.AbstractZkTestCase.putConfig put
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.xml to
> /configs/conf1/solrconfig.xml
> [junit4] 2> 105947 T417 oascc.SolrZkClient.makePath makePath:
> /configs/conf1/solrconfig.xml
> [junit4] 2> 105953 T417 oasc.AbstractZkTestCase.putConfig put
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/schema.xml to
> /configs/conf1/schema.xml
> [junit4] 2> 105953 T417 oascc.SolrZkClient.makePath makePath:
> /configs/conf1/schema.xml
> [junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
> because it doesn't exist
> [junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/stopwords.txt because it
> doesn't exist
> [junit4] 2> 105957 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/protwords.txt because it
> doesn't exist
> [junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/currency.xml because it
> doesn't exist
> [junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/enumsConfig.xml because
> it doesn't exist
> [junit4] 2> 105958 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/open-exchange-rates.json
> because it doesn't exist
> [junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/mapping-ISOLatin1Accent.txt
> because it doesn't exist
> [junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/old_synonyms.txt because
> it doesn't exist
> [junit4] 2> 105959 T417 oasc.AbstractZkTestCase.putConfig skipping
> /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> solrj/src/test-files/solrj/solr/collection1/conf/synonyms.txt because it
> doesn't exist
> [junit4] 2> 106110 T417 oas.SolrTestCaseJ4.writeCoreProperties
> Writing core.properties file to /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/cores/collection1
> [junit4] 2> 106112 T417 oejs.Server.doStart jetty-8.1.10.v20130312
> [junit4] 2> 106115 T417 oejs.AbstractConnector.doStart Started
> SelectChannelConnector@127.0.0.1:36913
> [junit4] 2> 106116 T417 oass.SolrDispatchFilter.init
> SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
> [junit4] 2> 106116 T417 oasc.SolrResourceLoader.locateSolrHome JNDI
> not configured for solr (NoInitialContextEx)
> [junit4] 2> 106117 T417 oasc.SolrResourceLoader.locateSolrHome using
> system property solr.solr.home: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001
> [junit4] 2> 106117 T417 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/'
> [junit4] 2> 106134 T417 oasc.ConfigSolr.fromFile Loading container
> configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/control-001/solr.xml
> [junit4] 2> 106141 T417 oasc.CorePropertiesLocator.<init>
> Config-defined core root directory: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/cores
> [junit4] 2> 106141 T417 oasc.CoreContainer.<init> New CoreContainer
> 10037181
> [junit4] 2> 106142 T417 oasc.CoreContainer.load Loading cores into
> CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/control-001/]
> [junit4] 2> 106142 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting socketTimeout to: 90000
> [junit4] 2> 106143 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting urlScheme to:
> [junit4] 2> 106143 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting connTimeout to: 15000
> [junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnectionsPerHost to: 20
> [junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnections to: 10000
> [junit4] 2> 106144 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting corePoolSize to: 0
> [junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maximumPoolSize to: 2147483647
> [junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxThreadIdleTime to: 5
> [junit4] 2> 106145 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting sizeOfQueue to: -1
> [junit4] 2> 106146 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting fairnessPolicy to: false
> [junit4] 2> 106146 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting useRetries to: false
> [junit4] 2> 106147 T417 oasu.UpdateShardHandler.<init> Creating
> UpdateShardHandler HTTP client with params: socketTimeout=340000&
> connTimeout=45000&retry=true
> [junit4] 2> 106147 T417 oasl.LogWatcher.createWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 106148 T417 oasl.LogWatcher.newRegisteredLogWatcher
> Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 106148 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
> [junit4] 2> 106148 T417 oasc.ZkContainer.initZooKeeper Zookeeper
> client=127.0.0.1:35500/solr
> [junit4] 2> 106164 T417 oasc.ZkController.checkChrootPath zkHost
> includes chroot
> [junit4] 2> 106165 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 106165 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 106176 T454 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@915c9a
> name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 106176 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 106177 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 106185 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 106196 T457 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@b547d5
> name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 106196 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 106206 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/queue
> [junit4] 2> 106407 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/collection-queue-work
> [junit4] 2> 106412 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/collection-map-running
> [junit4] 2> 106415 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/collection-map-completed
> [junit4] 2> 106419 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/collection-map-failure
> [junit4] 2> 106427 T417 oascc.SolrZkClient.makePath makePath:
> /live_nodes
> [junit4] 2> 106429 T417 oasc.ZkController.createEphemeralLiveNode
> Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36913_
> [junit4] 2> 106431 T417 oascc.SolrZkClient.makePath makePath:
> /live_nodes/127.0.0.1:36913_
> [junit4] 2> 106433 T417 oascc.SolrZkClient.makePath makePath:
> /overseer_elect
> [junit4] 2> 106435 T417 oascc.SolrZkClient.makePath makePath:
> /overseer_elect/election
> [junit4] 2> 106437 T417 oasc.Overseer.close Overseer (id=null) closing
> [junit4] 2> 106442 T417 oasc.OverseerElectionContext.runLeaderProcess
> I am going to be the leader 127.0.0.1:36913_
> [junit4] 2> 106442 T417 oascc.SolrZkClient.makePath makePath:
> /overseer_elect/leader
> [junit4] 2> 106444 T417 oasc.Overseer.start Overseer
> (id=93342907826307075-127.0.0.1:36913_-n_0000000000) starting
> [junit4] 2> 106450 T417 oascc.SolrZkClient.makePath makePath:
> /overseer/queue-work
> [junit4] 2> 106470 T417 oasc.OverseerAutoReplicaFailoverThread.<init>
> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
> autoReplicaFailoverWaitAfterExpiration=30000
> autoReplicaFailoverBadNodeExpiration=60000
> [junit4] 2> 106478 T459 oasc.OverseerCollectionProcessor.run Process
> current queue of collection creations
> [junit4] 2> 106479 T417 oascc.SolrZkClient.makePath makePath:
> /clusterstate.json
> [junit4] 2> 106481 T417 oascc.SolrZkClient.makePath makePath:
> /aliases.json
> [junit4] 2> 106483 T417 oascc.ZkStateReader.
> createClusterStateWatchersAndUpdate Updating cluster state from
> ZooKeeper...
> [junit4] 2> 106490 T458 oasc.Overseer$ClusterStateUpdater.run
> Starting to work on the main queue
> [junit4] 2> 106490 T417 oasc.CorePropertiesLocator.discover Looking
> for core definitions underneath /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/cores
> [junit4] 2> 106493 T417 oasc.CorePropertiesLocator.discoverUnder
> Found core collection1 in /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/cores/collection1/
> [junit4] 2> 106493 T417 oasc.CorePropertiesLocator.discover Found 1
> core definitions
> [junit4] 2> 106495 T461 oasc.ZkController.publish publishing
> core=collection1 state=down collection=control_collection
> [junit4] 2> 106495 T461 oasc.ZkController.publish numShards not found
> on descriptor - reading it from system property
> [junit4] 2> 106500 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 106500 T461 oasc.ZkController.waitForCoreNodeName look
> for our core node name
> [junit4] 2> 106504 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 0, message = {
> [junit4] 2> "core":"collection1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:36913",
> [junit4] 2> "node_name":"127.0.0.1:36913_",
> [junit4] 2> "numShards":"1",
> [junit4] 2> "state":"down",
> [junit4] 2> "shard":null,
> [junit4] 2> "collection":"control_collection",
> [junit4] 2> "operation":"state"} current state version: 0
> [junit4] 2> 106517 T458 oasco.ReplicaMutator.updateState Update
> state numShards=1 message={
> [junit4] 2> "core":"collection1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:36913",
> [junit4] 2> "node_name":"127.0.0.1:36913_",
> [junit4] 2> "numShards":"1",
> [junit4] 2> "state":"down",
> [junit4] 2> "shard":null,
> [junit4] 2> "collection":"control_collection",
> [junit4] 2> "operation":"state"}
> [junit4] 2> 106519 T458 oasco.ClusterStateMutator.createCollection
> building a new cName: control_collection
> [junit4] 2> 106530 T458 oasco.ReplicaMutator.updateState Assigning
> new node to shard shard=shard1
> [junit4] 2> 106536 T457 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> 107501 T461 oasc.ZkController.waitForShardId waiting to
> find shard id in clusterstate for collection1
> [junit4] 2> 107501 T461 oasc.ZkController.createCollectionZkNode
> Check for collection zkNode:control_collection
> [junit4] 2> 107502 T461 oasc.ZkController.createCollectionZkNode
> Collection zkNode exists
> [junit4] 2> 107502 T461 oascc.ZkStateReader.readConfigName Load
> collection config from:/collections/control_collection
> [junit4] 2> 107503 T461 oascc.ZkStateReader.readConfigName
> path=/collections/control_collection configName=conf1 specified config
> exists in ZooKeeper
> [junit4] 2> 107503 T461 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/control-
> 001/cores/collection1/'
> [junit4] 2> 107515 T461 oasc.ZkController.watchZKConfDir watch zkdir
> /configs/conf1
> [junit4] 2> 107518 T461 oasc.Config.<init> loaded config
> solrconfig.xml with version 0
> [junit4] 2> 107522 T461 oasc.SolrConfig.refreshRequestParams current
> version of requestparams : -1
> [junit4] 2> 107525 T461 oasc.SolrConfig.<init> Using Lucene
> MatchVersion: 5.0.0
> [junit4] 2> 107536 T461 oasc.SolrConfig.<init> Loaded SolrConfig:
> solrconfig.xml
> [junit4] 2> 107537 T461 oass.IndexSchema.readSchema Reading Solr
> Schema from /configs/conf1/schema.xml
> [junit4] 2> 107544 T461 oass.IndexSchema.readSchema [collection1]
> Schema name=test
> [junit4] 2> 107667 T461 oass.IndexSchema.readSchema default search
> field in schema is text
> [junit4] 2> 107668 T461 oass.IndexSchema.readSchema unique key field:
> id
> [junit4] 2> 107668 T461 oass.IndexSchema.loadCopyFields WARN Field
> lowerfilt1and2 is not multivalued and destination for multiple copyFields
> (2)
> [junit4] 2> 107669 T461 oass.IndexSchema.loadCopyFields WARN Field
> text is not multivalued and destination for multiple copyFields (3)
> [junit4] 2> 107671 T461 oasc.CoreContainer.create Creating SolrCore
> 'collection1' using configuration from collection control_collection
> [junit4] 2> 107671 T461 oasc.SolrCore.initDirectoryFactory
> org.apache.solr.core.MockDirectoryFactory
> [junit4] 2> 107672 T461 oasc.SolrCore.<init> [collection1] Opening
> new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/control-001/cores/collection1/,
> dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/control/data/
> [junit4] 2> 107672 T461 oasc.SolrCore.<init> JMX monitoring not
> detected for core: collection1
> [junit4] 2> 107672 T461 oasc.CachingDirectoryFactory.get return new
> directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/control/data
> [junit4] 2> 107672 T461 oasc.SolrCore.getNewIndexDir New index
> directory detected: old=null new=/mnt/ssd/jenkins/
> workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/
> test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/control/data/index/
> [junit4] 2> 107673 T461 oasc.SolrCore.initIndex WARN [collection1]
> Solr index directory '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/control/data/index'
> doesn't exist. Creating new index...
> [junit4] 2> 107673 T461 oasc.CachingDirectoryFactory.get return new
> directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/control/data/index
> [junit4] 2> 107674 T461 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=1
> [junit4] 2> commit{dir=MockDirectoryWrapper(
> RAMDirectory@1fcf0b2 lockFactory=org.apache.lucene.store.
> SingleInstanceLockFactory@296d3b),segFN=segments_1,generation=1}
> [junit4] 2> 107674 T461 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 1
> [junit4] 2> 107674 T461 oasc.SolrCore.loadUpdateProcessorChains no
> updateRequestProcessorChain defined as default, creating implicit default
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /update/json: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /update/csv: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /config: org.apache.solr.handler.SolrConfigHandler
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /schema: org.apache.solr.handler.SchemaHandler
> [junit4] 2> 107675 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
> [junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
> [junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
> [junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
> [junit4] 2> 107676 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
> [junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/properties: org.apache.solr.handler.admin.
> PropertiesRequestHandler
> [junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
> [junit4] 2> 107677 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
> [junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /get: solr.RealTimeGetHandler
> [junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig
> adding lazy requestHandler: solr.ReplicationHandler
> [junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /replication: solr.ReplicationHandler
> [junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig
> created standard: solr.StandardRequestHandler
> [junit4] 2> 107680 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /update: solr.UpdateRequestHandler
> [junit4] 2> 107680 T461 oasc.SolrResourceLoader.findClass WARN Solr
> loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers].
> Please consult documentation how to replace it accordingly.
> [junit4] 2> 107681 T461 oasc.SolrResourceLoader.findClass WARN Solr
> loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers].
> Please consult documentation how to replace it accordingly.
> [junit4] 2> 107681 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/: org.apache.solr.handler.admin.AdminHandlers
> [junit4] 2> 107683 T461 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/ping: solr.PingRequestHandler
> [junit4] 2> 107684 T461 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 107685 T461 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 107686 T461 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 107686 T461 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 107687 T461 oasc.SolrCore.initStatsCache Using default
> statsCache cache: org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 107687 T461 oasu.CommitTracker.<init> Hard AutoCommit:
> disabled
> [junit4] 2> 107688 T461 oasu.CommitTracker.<init> Soft AutoCommit:
> disabled
> [junit4] 2> 107688 T461 oasc.SolrDeletionPolicy.onInit
> SolrDeletionPolicy.onInit: commits: num=1
> [junit4] 2> commit{dir=MockDirectoryWrapper(
> RAMDirectory@1fcf0b2 lockFactory=org.apache.lucene.store.
> SingleInstanceLockFactory@296d3b),segFN=segments_1,generation=1}
> [junit4] 2> 107688 T461 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 1
> [junit4] 2> 107689 T461 oass.SolrIndexSearcher.<init> Opening
> Searcher@7ab1a8[collection1] main
> [junit4] 2> 107689 T461 oascc.ZkStateReader.readConfigName Load
> collection config from:/collections/control_collection
> [junit4] 2> 107690 T461 oascc.ZkStateReader.readConfigName
> path=/collections/control_collection configName=conf1 specified config
> exists in ZooKeeper
> [junit4] 2> 107690 T461 oasr.ManagedResourceStorage.newStorageIO
> Setting up ZooKeeper-based storage for the RestManager with znodeBase:
> /configs/conf1
> [junit4] 2> 107692 T461 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure
> Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
> [junit4] 2> 107692 T461 oasr.RestManager.init Initializing
> RestManager with initArgs: {}
> [junit4] 2> 107692 T461 oasr.ManagedResourceStorage.load Reading
> _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
> [junit4] 2> 107693 T461 oasr.ManagedResourceStorage$
> ZooKeeperStorageIO.openInputStream No data found for znode
> /configs/conf1/_rest_managed.json
> [junit4] 2> 107693 T461 oasr.ManagedResourceStorage.load Loaded null
> at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
> [junit4] 2> 107693 T461 oasr.RestManager.init Initializing 0
> registered ManagedResources
> [junit4] 2> 107693 T461 oasha.AdminHandlers.inform WARN
> <requestHandler name="/admin/"
> [junit4] 2> class="solr.admin.AdminHandlers" /> is
> deprecated . It is not required anymore
> [junit4] 2> 107694 T462 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@7ab1a8[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 107695 T461 oasc.CoreContainer.registerCore registering
> core: collection1
> [junit4] 2> 107695 T465 oasc.ZkController.register Register replica -
> core:collection1 address:http://127.0.0.1:36913
> collection:control_collection shard:shard1
> [junit4] 2> 107696 T417 oass.SolrDispatchFilter.init
> user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0
> [junit4] 2> 107696 T417 oass.SolrDispatchFilter.init
> SolrDispatchFilter.init() done
> [junit4] 2> 107697 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 107697 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 107699 T468 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@127ae07
> name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 107699 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 107699 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 107702 T417 oascc.ZkStateReader.
> createClusterStateWatchersAndUpdate Updating cluster state from
> ZooKeeper...
> [junit4] 2> 107706 T417 oasc.ChaosMonkey.monkeyLog monkey: init -
> expire sessions:false cause connection loss:false
> [junit4] 2> 107710 T465 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection/leader_elect/shard1/election
> [junit4] 2> 107735 T465 oasc.ShardLeaderElectionContext.runLeaderProcess
> Running the leader process for shard shard1
> [junit4] 2> 107737 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 107738 T465 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp
> Enough replicas found to continue.
> [junit4] 2> 107738 T465 oasc.ShardLeaderElectionContext.runLeaderProcess
> I may be the new leader - try and sync
> [junit4] 2> ASYNC NEW_CORE C329 name=collection1
> org.apache.solr.core.SolrCore@44efd0 url=http://127.0.0.1:36913/
> collection1 node=127.0.0.1:36913_ C329_STATE=coll:control_collection
> core:collection1 props:{core=collection1, base_url=http://127.0.0.1:36913,
> node_name=127.0.0.1:36913_, state=down}
> [junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.sync Sync
> replicas to http://127.0.0.1:36913/collection1/
> [junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.syncReplicas
> Sync Success - now sync replicas to me
> [junit4] 2> 107740 T465 C329 P36913 oasc.SyncStrategy.syncToMe
> http://127.0.0.1:36913/collection1/ has no replicas
> [junit4] 2> 107741 T465 oasc.ShardLeaderElectionContext.runLeaderProcess
> I am the new leader: http://127.0.0.1:36913/collection1/ shard1
> [junit4] 2> 107743 T465 oascc.SolrZkClient.makePath makePath:
> /collections/control_collection/leaders/shard1
> [junit4] 2> 107743 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "operation":"leader",
> [junit4] 2> "shard":"shard1",
> [junit4] 2> "collection":"control_collection"} current
> state version: 1
> [junit4] 2> 107751 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 107764 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "operation":"leader",
> [junit4] 2> "shard":"shard1",
> [junit4] 2> "collection":"control_collection",
> [junit4] 2> "base_url":"http://127.0.0.1:36913",
> [junit4] 2> "core":"collection1",
> [junit4] 2> "state":"active"} current state version: 1
> [junit4] 2> 107805 T417 oas.SolrTestCaseJ4.writeCoreProperties
> Writing core.properties file to /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/cores/collection1
> [junit4] 2> 107806 T417 oasc.AbstractFullDistribZkTestBase.createJettys
> create jetty 1
> [junit4] 2> 107807 T417 oejs.Server.doStart jetty-8.1.10.v20130312
> [junit4] 2> 107811 T417 oejs.AbstractConnector.doStart Started
> SelectChannelConnector@127.0.0.1:56075
> [junit4] 2> 107812 T417 oass.SolrDispatchFilter.init
> SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
> [junit4] 2> 107812 T417 oasc.SolrResourceLoader.locateSolrHome JNDI
> not configured for solr (NoInitialContextEx)
> [junit4] 2> 107812 T417 oasc.SolrResourceLoader.locateSolrHome using
> system property solr.solr.home: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001
> [junit4] 2> 107813 T417 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/'
> [junit4] 2> 107823 T417 oasc.ConfigSolr.fromFile Loading container
> configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/shard-1-001/solr.xml
> [junit4] 2> 107828 T417 oasc.CorePropertiesLocator.<init>
> Config-defined core root directory: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/cores
> [junit4] 2> 107828 T417 oasc.CoreContainer.<init> New CoreContainer
> 32563491
> [junit4] 2> 107829 T417 oasc.CoreContainer.load Loading cores into
> CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/shard-1-001/]
> [junit4] 2> 107829 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting socketTimeout to: 90000
> [junit4] 2> 107829 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting urlScheme to:
> [junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting connTimeout to: 15000
> [junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnectionsPerHost to: 20
> [junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnections to: 10000
> [junit4] 2> 107830 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting corePoolSize to: 0
> [junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maximumPoolSize to: 2147483647
> [junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxThreadIdleTime to: 5
> [junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting sizeOfQueue to: -1
> [junit4] 2> 107831 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting fairnessPolicy to: false
> [junit4] 2> 107832 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting useRetries to: false
> [junit4] 2> 107832 T417 oasu.UpdateShardHandler.<init> Creating
> UpdateShardHandler HTTP client with params: socketTimeout=340000&
> connTimeout=45000&retry=true
> [junit4] 2> 107832 T417 oasl.LogWatcher.createWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 107833 T417 oasl.LogWatcher.newRegisteredLogWatcher
> Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 107833 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
> [junit4] 2> 107833 T417 oasc.ZkContainer.initZooKeeper Zookeeper
> client=127.0.0.1:35500/solr
> [junit4] 2> 107833 T417 oasc.ZkController.checkChrootPath zkHost
> includes chroot
> [junit4] 2> 107834 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 107834 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 107836 T480 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@df0348
> name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 107837 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 107837 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 107839 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 107841 T483 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@75271e
> name:ZooKeeperConnection Watcher:127.0.0.1:35500/solr got event
> WatchedEvent state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 107841 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 107847 T417 oascc.ZkStateReader.
> createClusterStateWatchersAndUpdate Updating cluster state from
> ZooKeeper...
> [junit4] 2> 107867 T483 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> 107867 T457 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> 107867 T468 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> 107914 T465 oasc.ZkController.register We are
> http://127.0.0.1:36913/collection1/ and leader is http://127.0.0.1:36913/
> collection1/
> [junit4] 2> 107914 T465 oasc.ZkController.register No LogReplay
> needed for core=collection1 baseURL=http://127.0.0.1:36913
> [junit4] 2> 107914 T465 oasc.ZkController.checkRecovery I am the
> leader, no recovery necessary
> [junit4] 2> 107915 T465 oasc.ZkController.publish publishing
> core=collection1 state=active collection=control_collection
> [junit4] 2> 107915 T465 oasc.ZkController.publish numShards not found
> on descriptor - reading it from system property
> [junit4] 2> 107916 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 107923 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "core":"collection1",
> [junit4] 2> "core_node_name":"core_node1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:36913",
> [junit4] 2> "node_name":"127.0.0.1:36913_",
> [junit4] 2> "numShards":"2",
> [junit4] 2> "state":"active",
> [junit4] 2> "shard":"shard1",
> [junit4] 2> "collection":"control_collection",
> [junit4] 2> "operation":"state"} current state version: 2
> [junit4] 2> 107924 T458 oasco.ReplicaMutator.updateState Update
> state numShards=2 message={
> [junit4] 2> "core":"collection1",
> [junit4] 2> "core_node_name":"core_node1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:36913",
> [junit4] 2> "node_name":"127.0.0.1:36913_",
> [junit4] 2> "numShards":"2",
> [junit4] 2> "state":"active",
> [junit4] 2> "shard":"shard1",
> [junit4] 2> "collection":"control_collection",
> [junit4] 2> "operation":"state"}
> [junit4] 2> 108027 T468 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> 108027 T483 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> 108028 T457 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> 108850 T417 oasc.ZkController.createEphemeralLiveNode
> Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56075_
> [junit4] 2> 108851 T417 oascc.SolrZkClient.makePath makePath:
> /live_nodes/127.0.0.1:56075_
> [junit4] 2> 108855 T417 oasc.Overseer.close Overseer (id=null) closing
> [junit4] 2> 108858 T417 oasc.CorePropertiesLocator.discover Looking
> for core definitions underneath /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/cores
> [junit4] 2> 108859 T417 oasc.CorePropertiesLocator.discoverUnder
> Found core collection1 in /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/cores/collection1/
> [junit4] 2> 108859 T417 oasc.CorePropertiesLocator.discover Found 1
> core definitions
> [junit4] 2> 108860 T484 oasc.ZkController.publish publishing
> core=collection1 state=down collection=collection1
> [junit4] 2> 108860 T484 oasc.ZkController.publish numShards not found
> on descriptor - reading it from system property
> [junit4] 2> 108861 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 108861 T484 oasc.ZkController.waitForCoreNodeName look
> for our core node name
> [junit4] 2> 108862 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "core":"collection1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:56075",
> [junit4] 2> "node_name":"127.0.0.1:56075_",
> [junit4] 2> "numShards":"2",
> [junit4] 2> "state":"down",
> [junit4] 2> "shard":null,
> [junit4] 2> "collection":"collection1",
> [junit4] 2> "operation":"state"} current state version: 3
> [junit4] 2> 108863 T458 oasco.ReplicaMutator.updateState Update
> state numShards=2 message={
> [junit4] 2> "core":"collection1",
> [junit4] 2> "roles":null,
> [junit4] 2> "base_url":"http://127.0.0.1:56075",
> [junit4] 2> "node_name":"127.0.0.1:56075_",
> [junit4] 2> "numShards":"2",
> [junit4] 2> "state":"down",
> [junit4] 2> "shard":null,
> [junit4] 2> "collection":"collection1",
> [junit4] 2> "operation":"state"}
> [junit4] 2> 108863 T458 oasco.ClusterStateMutator.createCollection
> building a new cName: collection1
> [junit4] 2> 108863 T458 oasco.ReplicaMutator.updateState Assigning
> new node to shard shard=shard2
> [junit4] 2> 108967 T468 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 108967 T457 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 108967 T483 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 109862 T484 oasc.ZkController.waitForShardId waiting to
> find shard id in clusterstate for collection1
> [junit4] 2> 109862 T484 oasc.ZkController.createCollectionZkNode
> Check for collection zkNode:collection1
> [junit4] 2> 109863 T484 oasc.ZkController.createCollectionZkNode
> Collection zkNode exists
> [junit4] 2> 109863 T484 oascc.ZkStateReader.readConfigName Load
> collection config from:/collections/collection1
> [junit4] 2> 109864 T484 oascc.ZkStateReader.readConfigName
> path=/collections/collection1 configName=conf1 specified config exists in
> ZooKeeper
> [junit4] 2> 109864 T484 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-1-
> 001/cores/collection1/'
> [junit4] 2> 109874 T484 oasc.ZkController.watchZKConfDir watch zkdir
> /configs/conf1
> [junit4] 2> 109876 T484 oasc.Config.<init> loaded config
> solrconfig.xml with version 0
> [junit4] 2> 109879 T484 oasc.SolrConfig.refreshRequestParams current
> version of requestparams : -1
> [junit4] 2> 109888 T484 oasc.SolrConfig.<init> Using Lucene
> MatchVersion: 5.0.0
> [junit4] 2> 109895 T484 oasc.SolrConfig.<init> Loaded SolrConfig:
> solrconfig.xml
> [junit4] 2> 109901 T484 oass.IndexSchema.readSchema Reading Solr
> Schema from /configs/conf1/schema.xml
> [junit4] 2> 109905 T484 oass.IndexSchema.readSchema [collection1]
> Schema name=test
> [junit4] 2> 109996 T484 oass.IndexSchema.readSchema default search
> field in schema is text
> [junit4] 2> 109998 T484 oass.IndexSchema.readSchema unique key field:
> id
> [junit4] 2> 109999 T484 oass.IndexSchema.loadCopyFields WARN Field
> lowerfilt1and2 is not multivalued and destination for multiple copyFields
> (2)
> [junit4] 2> 110002 T484 oass.IndexSchema.loadCopyFields WARN Field
> text is not multivalued and destination for multiple copyFields (3)
> [junit4] 2> 110002 T484 oasc.CoreContainer.create Creating SolrCore
> 'collection1' using configuration from collection collection1
> [junit4] 2> 110003 T484 oasc.SolrCore.initDirectoryFactory
> org.apache.solr.core.MockDirectoryFactory
> [junit4] 2> 110003 T484 oasc.SolrCore.<init> [collection1] Opening
> new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/shard-1-001/cores/collection1/,
> dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/jetty1/
> [junit4] 2> 110003 T484 oasc.SolrCore.<init> JMX monitoring not
> detected for core: collection1
> [junit4] 2> 110003 T484 oasc.CachingDirectoryFactory.get return new
> directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/jetty1
> [junit4] 2> 110004 T484 oasc.SolrCore.getNewIndexDir New index
> directory detected: old=null new=/mnt/ssd/jenkins/
> workspace/Lucene-Solr-5.0-Linux/solr/build/solr-solrj/
> test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/jetty1/index/
> [junit4] 2> 110004 T484 oasc.SolrCore.initIndex WARN [collection1]
> Solr index directory '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/tempDir-002/jetty1/index'
> doesn't exist. Creating new index...
> [junit4] 2> 110004 T484 oasc.CachingDirectoryFactory.get return new
> directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/tempDir-002/jetty1/index
> [junit4] 2> 110004 T484 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=1
> [junit4] 2> commit{dir=MockDirectoryWrapper(
> RAMDirectory@b4a931 lockFactory=org.apache.lucene.store.
> SingleInstanceLockFactory@d1df76),segFN=segments_1,generation=1}
> [junit4] 2> 110005 T484 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 1
> [junit4] 2> 110005 T484 oasc.SolrCore.loadUpdateProcessorChains no
> updateRequestProcessorChain defined as default, creating implicit default
> [junit4] 2> 110005 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /update/json: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /update/csv: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
> [junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /config: org.apache.solr.handler.SolrConfigHandler
> [junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /schema: org.apache.solr.handler.SchemaHandler
> [junit4] 2> 110006 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
> [junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
> [junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
> [junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
> [junit4] 2> 110007 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
> [junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/properties: org.apache.solr.handler.admin.
> PropertiesRequestHandler
> [junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
> [junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
> [junit4] 2> 110008 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /get: solr.RealTimeGetHandler
> [junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig
> adding lazy requestHandler: solr.ReplicationHandler
> [junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /replication: solr.ReplicationHandler
> [junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig
> created standard: solr.StandardRequestHandler
> [junit4] 2> 110009 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /update: solr.UpdateRequestHandler
> [junit4] 2> 110009 T484 oasc.SolrResourceLoader.findClass WARN Solr
> loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers].
> Please consult documentation how to replace it accordingly.
> [junit4] 2> 110010 T484 oasc.SolrResourceLoader.findClass WARN Solr
> loaded a deprecated plugin/analysis class [org.apache.solr.handler.admin.AdminHandlers].
> Please consult documentation how to replace it accordingly.
> [junit4] 2> 110010 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/: org.apache.solr.handler.admin.AdminHandlers
> [junit4] 2> 110010 T484 oasc.RequestHandlers.initHandlersFromConfig
> created /admin/ping: solr.PingRequestHandler
> [junit4] 2> 110011 T484 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 110012 T484 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 110013 T484 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 110013 T484 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 110014 T484 oasc.SolrCore.initStatsCache Using default
> statsCache cache: org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 110014 T484 oasu.CommitTracker.<init> Hard AutoCommit:
> disabled
> [junit4] 2> 110014 T484 oasu.CommitTracker.<init> Soft AutoCommit:
> disabled
> [junit4] 2> 110015 T484 oasc.SolrDeletionPolicy.onInit
> SolrDeletionPolicy.onInit: commits: num=1
> [junit4] 2> commit{dir=MockDirectoryWrapper(
> RAMDirectory@b4a931 lockFactory=org.apache.lucene.store.
> SingleInstanceLockFactory@d1df76),segFN=segments_1,generation=1}
> [junit4] 2> 110015 T484 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 1
> [junit4] 2> 110015 T484 oass.SolrIndexSearcher.<init> Opening
> Searcher@a60e3b[collection1] main
> [junit4] 2> 110015 T484 oascc.ZkStateReader.readConfigName Load
> collection config from:/collections/collection1
> [junit4] 2> 110019 T484 oascc.ZkStateReader.readConfigName
> path=/collections/collection1 configName=conf1 specified config exists in
> ZooKeeper
> [junit4] 2> 110020 T484 oasr.ManagedResourceStorage.newStorageIO
> Setting up ZooKeeper-based storage for the RestManager with znodeBase:
> /configs/conf1
> [junit4] 2> 110020 T484 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure
> Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
> [junit4] 2> 110020 T484 oasr.RestManager.init Initializing
> RestManager with initArgs: {}
> [junit4] 2> 110020 T484 oasr.ManagedResourceStorage.load Reading
> _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
> [junit4] 2> 110021 T484 oasr.ManagedResourceStorage$
> ZooKeeperStorageIO.openInputStream No data found for znode
> /configs/conf1/_rest_managed.json
> [junit4] 2> 110021 T484 oasr.ManagedResourceStorage.load Loaded null
> at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
> [junit4] 2> 110021 T484 oasr.RestManager.init Initializing 0
> registered ManagedResources
> [junit4] 2> 110021 T484 oasha.AdminHandlers.inform WARN
> <requestHandler name="/admin/"
> [junit4] 2> class="solr.admin.AdminHandlers" /> is
> deprecated . It is not required anymore
> [junit4] 2> 110022 T484 oasc.CoreContainer.registerCore registering
> core: collection1
> [junit4] 2> 110022 T488 oasc.ZkController.register Register replica -
> core:collection1 address:http://127.0.0.1:56075 collection:collection1
> shard:shard2
> [junit4] 2> 110023 T485 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@a60e3b[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 110024 T417 oass.SolrDispatchFilter.init
> user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0
> [junit4] 2> 110024 T417 oass.SolrDispatchFilter.init
> SolrDispatchFilter.init() done
> [junit4] 2> 110030 T488 oascc.SolrZkClient.makePath makePath:
> /collections/collection1/leader_elect/shard2/election
> [junit4] 2> 110034 T488 oasc.ShardLeaderElectionContext.runLeaderProcess
> Running the leader process for shard shard2
> [junit4] 2> 110036 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 110036 T488 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp
> Enough replicas found to continue.
> [junit4] 2> 110036 T488 oasc.ShardLeaderElectionContext.runLeaderProcess
> I may be the new leader - try and sync
> [junit4] 2> ASYNC NEW_CORE C330 name=collection1
> org.apache.solr.core.SolrCore@45b641 url=http://127.0.0.1:56075/
> collection1 node=127.0.0.1:56075_ C330_STATE=coll:collection1
> core:collection1 props:{core=collection1, base_url=http://127.0.0.1:56075,
> node_name=127.0.0.1:56075_, state=down}
> [junit4] 2> 110036 T488 C330 P56075 oasc.SyncStrategy.sync Sync
> replicas to http://127.0.0.1:56075/collection1/
> [junit4] 2> 110037 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "operation":"leader",
> [junit4] 2> "shard":"shard2",
> [junit4] 2> "collection":"collection1"} current state
> version: 4
> [junit4] 2> 110037 T488 C330 P56075 oasc.SyncStrategy.syncReplicas
> Sync Success - now sync replicas to me
> [junit4] 2> 110037 T488 C330 P56075 oasc.SyncStrategy.syncToMe
> http://127.0.0.1:56075/collection1/ has no replicas
> [junit4] 2> 110038 T488 oasc.ShardLeaderElectionContext.runLeaderProcess
> I am the new leader: http://127.0.0.1:56075/collection1/ shard2
> [junit4] 2> 110038 T488 oascc.SolrZkClient.makePath makePath:
> /collections/collection1/leaders/shard2
> [junit4] 2> 110042 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 110043 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "operation":"leader",
> [junit4] 2> "shard":"shard2",
> [junit4] 2> "collection":"collection1",
> [junit4] 2> "base_url":"http://127.0.0.1:56075",
> [junit4] 2> "core":"collection1",
> [junit4] 2> "state":"active"} current state version: 4
> [junit4] 2> 110146 T468 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 110146 T483 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 110146 T457 oascc.ZkStateReader$2.process A cluster state
> change: WatchedEvent state:SyncConnected type:NodeDataChanged
> path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
> [junit4] 2> 110155 T417 oas.SolrTestCaseJ4.writeCoreProperties
> Writing core.properties file to /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-
> 001/cores/collection1
> [junit4] 2> 110157 T417 oasc.AbstractFullDistribZkTestBase.createJettys
> create jetty 2
> [junit4] 2> 110157 T417 oejs.Server.doStart jetty-8.1.10.v20130312
> [junit4] 2> 110160 T417 oejs.AbstractConnector.doStart Started
> SelectChannelConnector@127.0.0.1:53262
> [junit4] 2> 110160 T417 oass.SolrDispatchFilter.init
> SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
> [junit4] 2> 110161 T417 oasc.SolrResourceLoader.locateSolrHome JNDI
> not configured for solr (NoInitialContextEx)
> [junit4] 2> 110161 T417 oasc.SolrResourceLoader.locateSolrHome using
> system property solr.solr.home: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-
> 001
> [junit4] 2> 110161 T417 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-
> 001/'
> [junit4] 2> 110178 T417 oasc.ConfigSolr.fromFile Loading container
> configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-Linux/solr/
> build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/shard-2-001/solr.xml
> [junit4] 2> 110184 T417 oasc.CorePropertiesLocator.<init>
> Config-defined core root directory: /mnt/ssd/jenkins/workspace/
> Lucene-Solr-5.0-Linux/solr/build/solr-solrj/test/J0/temp/
> solr.client.solrj.impl.CloudSolrClientTest 33DBA822D1639648-001/shard-2-
> 001/cores
> [junit4] 2> 110185 T417 oasc.CoreContainer.<init> New CoreContainer
> 5595126
> [junit4] 2> 110185 T417 oasc.CoreContainer.load Loading cores into
> CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.0-
> Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest
> 33DBA822D1639648-001/shard-2-001/]
> [junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting socketTimeout to: 90000
> [junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting urlScheme to:
> [junit4] 2> 110186 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting connTimeout to: 15000
> [junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnectionsPerHost to: 20
> [junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxConnections to: 10000
> [junit4] 2> 110187 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting corePoolSize to: 0
> [junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maximumPoolSize to: 2147483647
> [junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting maxThreadIdleTime to: 5
> [junit4] 2> 110188 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting sizeOfQueue to: -1
> [junit4] 2> 110189 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting fairnessPolicy to: false
> [junit4] 2> 110189 T417 oashc.HttpShardHandlerFactory.getParameter
> Setting useRetries to: false
> [junit4] 2> 110190 T417 oasu.UpdateShardHandler.<init> Creating
> UpdateShardHandler HTTP client with params: socketTimeout=340000&
> connTimeout=45000&retry=true
> [junit4] 2> 110190 T417 oasl.LogWatcher.createWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 110191 T417 oasl.LogWatcher.newRegisteredLogWatcher
> Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 110191 T417 oasc.CoreContainer.load Host Name: 127.0.0.1
> [junit4] 2> 110191 T417 oasc.ZkContainer.initZooKeeper Zookeeper
> client=127.0.0.1:35500/solr
> [junit4] 2> 110192 T417 oasc.ZkController.checkChrootPath zkHost
> includes chroot
> [junit4] 2> 110192 T417 oascc.SolrZkClient.
> createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
> [junit4] 2> 110193 T488 oasc.ZkController.register We are
> http://127.0.0.1:56075/collection1/ and leader is http://127.0.0.1:56075/
> collection1/
> [junit4] 2> 110193 T417 oascc.ConnectionManager.waitForConnected
> Waiting for client to connect to ZooKeeper
> [junit4] 2> 110194 T488 oasc.ZkController.register No LogReplay
> needed for core=collection1 baseURL=http://127.0.0.1:56075
> [junit4] 2> 110194 T488 oasc.ZkController.checkRecovery I am the
> leader, no recovery necessary
> [junit4] 2> 110194 T488 oasc.ZkController.publish publishing
> core=collection1 state=active collection=collection1
> [junit4] 2> 110195 T488 oasc.ZkController.publish numShards not found
> on descriptor - reading it from system property
> [junit4] 2> 110195 T500 oascc.ConnectionManager.process Watcher
> org.apache.solr.common.cloud.ConnectionManager@11e784e
> name:ZooKeeperConnection Watcher:127.0.0.1:35500 got event WatchedEvent
> state:SyncConnected type:None path:null path:null type:None
> [junit4] 2> 110196 T417 oascc.ConnectionManager.waitForConnected
> Client is connected to ZooKeeper
> [junit4] 2> 110196 T457 oasc.DistributedQueue$LatchWatcher.process
> NodeChildrenChanged fired on path /overseer/queue state SyncConnected
> [junit4] 2> 110196 T417 oascc.SolrZkClient.createZkACLProvider Using
> default ZkACLProvider
> [junit4] 2> 110197 T458 oasc.Overseer$ClusterStateUpdater.run
> processMessage: queueSize: 1, message = {
> [junit4] 2> "core":"collection1",
> [junit4] 2> "core_node_name":"core_node1",
> [junit