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 [email protected]: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 [email protected]: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 [email protected]: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
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
