Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1999/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC (asserts:
true)
2 tests failed.
FAILED: org.apache.solr.core.TestDynamicLoading.testDistribSearch
Error Message:
Could not successfully add blob { "responseHeader":{ "status":0,
"QTime":0}, "response":{ "numFound":1, "start":0, "docs":[{
"id":"test/1", "md5":"55617a38654319522ea3b9547a95f631",
"blobName":"test", "version":1,
"timestamp":"2015-01-08T08:21:35.603Z", "size":5222}]}}
Stack Trace:
java.lang.AssertionError: Could not successfully add blob {
"responseHeader":{
"status":0,
"QTime":0},
"response":{
"numFound":1,
"start":0,
"docs":[{
"id":"test/1",
"md5":"55617a38654319522ea3b9547a95f631",
"blobName":"test",
"version":1,
"timestamp":"2015-01-08T08:21:35.603Z",
"size":5222}]}}
at
__randomizedtesting.SeedInfo.seed([5737A1E1DF90297E:D6D12FF9A8CF4942]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.handler.TestBlobHandler.postAndCheck(TestBlobHandler.java:146)
at
org.apache.solr.core.TestDynamicLoading.dynamicLoading(TestDynamicLoading.java:111)
at
org.apache.solr.core.TestDynamicLoading.doTest(TestDynamicLoading.java:64)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
at sun.reflect.GeneratedMethodAccessor41.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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)
FAILED: org.apache.solr.handler.TestSolrConfigHandlerCloud.testDistribSearch
Error Message:
Could not get expected value /dump1 for path [overlay, requestHandler, /dump1,
name] full output { "responseHeader":{ "status":0, "QTime":0},
"overlay":{ "znodeVersion":3, "requestHandler":{"/dump":{
"name":"/dump", "class":"org.apache.solr.handler.DumpRequestHandler"}}}}
Stack Trace:
java.lang.AssertionError: Could not get expected value /dump1 for path
[overlay, requestHandler, /dump1, name] full output {
"responseHeader":{
"status":0,
"QTime":0},
"overlay":{
"znodeVersion":3,
"requestHandler":{"/dump":{
"name":"/dump",
"class":"org.apache.solr.handler.DumpRequestHandler"}}}}
at
__randomizedtesting.SeedInfo.seed([5737A1E1DF90297E:D6D12FF9A8CF4942]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:256)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.testReqParams(TestSolrConfigHandlerCloud.java:150)
at
org.apache.solr.handler.TestSolrConfigHandlerCloud.doTest(TestSolrConfigHandlerCloud.java:61)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
at sun.reflect.GeneratedMethodAccessor41.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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 10041 lines...]
[junit4] Suite: org.apache.solr.core.TestDynamicLoading
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/init-core-data-001
[junit4] 2> 5535343 T16779 oas.SolrTestCaseJ4.buildSSLConfig Randomized
ssl (false) and clientAuth (false)
[junit4] 2> 5535343 T16779
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 5535353 T16779 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 5535355 T16779 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 5535357 T16780 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 5535458 T16779 oasc.ZkTestServer.run start zk server on
port:60769
[junit4] 2> 5535459 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5535461 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5535474 T16787 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@dd7aa04 name:ZooKeeperConnection
Watcher:127.0.0.1:60769 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 5535475 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5535476 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5535476 T16779 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 5535494 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5535497 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5535505 T16790 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1000697 name:ZooKeeperConnection
Watcher:127.0.0.1:60769/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 5535506 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5535506 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5535507 T16779 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 5535517 T16779 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 5535529 T16779 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 5535537 T16779 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 5535547 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 5535549 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 5535563 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 5535564 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 5535574 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 5535575 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 5535589 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 5535589 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 5535597 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 5535598 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 5535606 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 5535607 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 5535615 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 5535617 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 5535633 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 5535637 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 5535644 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 5535646 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 5535653 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 5535654 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 5535660 T16779 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 5535661 T16779 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 5538005 T16779 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5538011 T16779 oejs.AbstractConnector.doStart Started
SelectChannelConnector@127.0.0.1:60772
[junit4] 2> 5538014 T16779 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@550a6723
[junit4] 2> 5538015 T16779 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5538016 T16779 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002
[junit4] 2> 5538017 T16779 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002/'
[junit4] 2> 5538086 T16779 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002/solr.xml
[junit4] 2> 5538170 T16779 oasc.CoreContainer.<init> New CoreContainer
1133852076
[junit4] 2> 5538170 T16779 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002/]
[junit4] 2> 5538173 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5538173 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5538174 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5538174 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5538174 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5538175 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5538175 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5538176 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5538176 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5538176 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5538178 T16779 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5538178 T16779 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5538179 T16779 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5538179 T16779 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5538180 T16779 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60769/solr
[junit4] 2> 5538180 T16779 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5538180 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5538182 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5538186 T16802 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5b290ae2
name:ZooKeeperConnection Watcher:127.0.0.1:60769 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5538187 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5538187 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5538194 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5538199 T16805 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@53367415
name:ZooKeeperConnection Watcher:127.0.0.1:60769/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5538199 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5538204 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 5538214 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 5538226 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 5538236 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 5538260 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 5538275 T16779 oascc.SolrZkClient.makePath makePath:
/live_nodes
[junit4] 2> 5538280 T16779 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60772_
[junit4] 2> 5538283 T16779 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60772_
[junit4] 2> 5538293 T16779 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 5538305 T16779 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 5538314 T16779 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5538318 T16779 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:60772_
[junit4] 2> 5538319 T16779 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 5538323 T16779 oasc.Overseer.start Overseer
(id=93107339929059331-127.0.0.1:60772_-n_0000000000) starting
[junit4] 2> 5538329 T16779 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 5538353 T16779 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 5538356 T16807 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 5538359 T16779 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 5538366 T16779 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 5538371 T16779
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5538383 T16806 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 5538387 T16809 oasc.ZkController.publish publishing
core=collection1 state=down collection=control_collection
[junit4] 2> 5538388 T16809 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5538390 T16809 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5538390 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5538397 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:60772_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60772"} current state
version: 0
[junit4] 2> 5538399 T16806 oasco.ReplicaMutator.updateState Update state
numShards=1 message={
[junit4] 2> "numShards":"1",
[junit4] 2> "node_name":"127.0.0.1:60772_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60772"}
[junit4] 2> 5538399 T16806 oasco.ClusterStateMutator.createCollection
building a new cName: control_collection
[junit4] 2> 5538399 T16806 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 5538404 T16805 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> 5539391 T16809 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5539393 T16809 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:control_collection
[junit4] 2> 5539395 T16809 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5539395 T16809 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 5539399 T16809 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 5539401 T16809 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002/collection1/'
[junit4] 2> 5539403 T16809 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-002/collection1/lib/.svn/'
to classloader
[junit4] 2> 5539406 T16809 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-002/collection1/lib/classes/'
to classloader
[junit4] 2> 5539411 T16809 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-002/collection1/lib/README'
to classloader
[junit4] 2> 5539486 T16809 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5539504 T16809 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5539530 T16809 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5539578 T16809 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5539675 T16809 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5539679 T16809 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5539693 T16809 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5540341 T16809 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5540350 T16809 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5540353 T16809 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5540389 T16809 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5540397 T16809 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5540403 T16809 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5540406 T16809
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5540407 T16809
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5540407 T16809 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5540410 T16809
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5540411 T16809
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5540411 T16809 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection control_collection
[junit4] 2> 5540412 T16809 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5540413 T16809 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-002/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/control/data/
[junit4] 2> 5540413 T16809 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c769de6
[junit4] 2> 5540414 T16809 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/control/data
[junit4] 2> 5540414 T16809 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/control/data/index/
[junit4] 2> 5540414 T16809 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/control/data/index' doesn't exist. Creating
new index...
[junit4] 2> 5540415 T16809 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/control/data/index
[junit4] 2> 5540416 T16809 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 5540417 T16809 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@241a44c4
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3898b260),segFN=segments_1,generation=1}
[junit4] 2> 5540418 T16809 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5540425 T16809 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5540425 T16809 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5540425 T16809 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5540426 T16809 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5540426 T16809 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5540426 T16809 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5540428 T16809 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5540428 T16809 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5540428 T16809 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5540429 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5540430 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5540431 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5540432 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5540432 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 5540434 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 5540436 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 5540437 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 5540437 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 5540442 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 5540443 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 5540444 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 5540445 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 5540446 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 5540447 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 5540447 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 5540448 T16809 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5540450 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5540450 T16809 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 5540467 T16809 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5540469 T16809 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5540471 T16809 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5540474 T16809 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5540475 T16809 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 5540481 T16809 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5540481 T16809 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5540482 T16809 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=16, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=61.015625,
floorSegmentMB=0.2666015625, forceMergeDeletesPctAllowed=10.085260096593478,
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 5540483 T16809 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@241a44c4
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3898b260),segFN=segments_1,generation=1}
[junit4] 2> 5540485 T16809 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5540485 T16809 oass.SolrIndexSearcher.<init> Opening
Searcher@4fc415d4[collection1] main
[junit4] 2> 5540486 T16809 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/control_collection
[junit4] 2> 5540490 T16809 oascc.ZkStateReader.readConfigName
path=/collections/control_collection configName=conf1 specified config exists
in ZooKeeper
[junit4] 2> 5540490 T16809 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5540494 T16809
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5540495 T16809 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5540495 T16809 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5540498 T16809
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5540498 T16809 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5540499 T16809 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 5540499 T16809 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 5540500 T16809 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 5540501 T16810 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@4fc415d4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5540504 T16813 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:60772 collection:control_collection
shard:shard1
[junit4] 2> 5540505 T16779 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5540506 T16779 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5540506 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5540507 T16813 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 5540509 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5540514 T16816 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2639024d
name:ZooKeeperConnection Watcher:127.0.0.1:60769/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5540515 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5540516 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5540527 T16779
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5540540 T16813
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 5540542 T16779 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 5540542 T16779 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 5540542 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5540545 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5540550 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5540551 T16819 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@311a30cf
name:ZooKeeperConnection Watcher:127.0.0.1:60769/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5540551 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5540551 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5540552 T16813
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 5540552 T16813
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C5988 name=collection1
org.apache.solr.core.SolrCore@3d3e90d2 url=http://127.0.0.1:60772/collection1
node=127.0.0.1:60772_ C5988_STATE=coll:control_collection core:collection1
props:{node_name=127.0.0.1:60772_, state=down, core=collection1,
base_url=http://127.0.0.1:60772}
[junit4] 2> 5540552 T16813 C5988 P60772 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:60772/collection1/
[junit4] 2> 5540553 T16813 C5988 P60772 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 5540553 T16813 C5988 P60772 oasc.SyncStrategy.syncToMe
http://127.0.0.1:60772/collection1/ has no replicas
[junit4] 2> 5540553 T16813
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:60772/collection1/ shard1
[junit4] 2> 5540553 T16813 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 5540553 T16806 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> 5540560 T16816 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> 5540561 T16805 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> 5540644 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 2
[junit4] 2> 5540645 T16806 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 5540681 T16820 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5540688 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:60772";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 5540690 T16806 oasco.ZkStateWriter.writePendingUpdates going
to create_collection /collections/collection1/state.json
[junit4] 2> 5540693 T16816 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> 5540816 T16816 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> 5540857 T16813 oasc.ZkController.register We are
http://127.0.0.1:60772/collection1/ and leader is
http://127.0.0.1:60772/collection1/
[junit4] 2> 5540857 T16813 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:60772
[junit4] 2> 5540858 T16813 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 5540858 T16813 oasc.ZkController.publish publishing
core=collection1 state=active collection=control_collection
[junit4] 2> 5540858 T16813 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5540864 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5540887 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60772_",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60772"} current state
version: 4
[junit4] 2> 5540893 T16806 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60772_",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60772"}
[junit4] 2> 5541011 T16805 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> 5541011 T16816 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> 5542913 T16779 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 5542914 T16779 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5542920 T16779 oejs.AbstractConnector.doStart Started
SelectChannelConnector@127.0.0.1:60777
[junit4] 2> 5542923 T16779 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@550a6723
[junit4] 2> 5542924 T16779 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5542925 T16779 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003
[junit4] 2> 5542926 T16779 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003/'
[junit4] 2> 5542990 T16779 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003/solr.xml
[junit4] 2> 5543126 T16779 oasc.CoreContainer.<init> New CoreContainer
844288666
[junit4] 2> 5543127 T16779 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003/]
[junit4] 2> 5543128 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5543129 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5543129 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5543129 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5543130 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5543130 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5543131 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5543131 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5543131 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5543132 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5543133 T16779 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5543134 T16779 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5543135 T16779 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5543135 T16779 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5543135 T16779 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60769/solr
[junit4] 2> 5543136 T16779 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5543137 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5543138 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5543145 T16832 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@34c11249
name:ZooKeeperConnection Watcher:127.0.0.1:60769 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5543145 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5543146 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5543152 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5543160 T16835 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@14ff6c6b
name:ZooKeeperConnection Watcher:127.0.0.1:60769/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5543161 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5543181 T16779
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5544200 T16779 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60777_
[junit4] 2> 5544202 T16779 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60777_
[junit4] 2> 5544219 T16779 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5544233 T16836 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 5544233 T16836 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5544236 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5544240 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60777_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60777"} current state
version: 5
[junit4] 2> 5544241 T16806 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60777_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60777"}
[junit4] 2> 5544241 T16806 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 5544241 T16806 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard1
[junit4] 2> 5544242 T16836 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 5544243 T16836 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 5544245 T16836 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 5544247 T16806 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 0
[junit4] 2> 5544250 T16835 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 5544252 T16836 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 1
[junit4] 2> 5544253 T16836 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5544253 T16836 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5544253 T16836 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 5544255 T16836 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5544255 T16836 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5544255 T16835 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 1
[junit4] 2> 5544260 T16836 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5544260 T16836 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003/collection1/'
[junit4] 2> 5544262 T16836 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-003/collection1/lib/.svn/'
to classloader
[junit4] 2> 5544262 T16836 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-003/collection1/lib/classes/'
to classloader
[junit4] 2> 5544264 T16836 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-003/collection1/lib/README'
to classloader
[junit4] 2> 5544307 T16836 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5544312 T16836 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5544328 T16836 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5544358 T16836 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5544417 T16836 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5544420 T16836 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5544431 T16836 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5545029 T16836 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5545046 T16836 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5545053 T16836 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5545086 T16836 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5545099 T16836 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5545107 T16836 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5545110 T16836
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5545110 T16836
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5545110 T16836 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5545114 T16836
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5545115 T16836
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5545115 T16836 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 5545116 T16836 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5545117 T16836 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-003/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty1/
[junit4] 2> 5545117 T16836 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c769de6
[junit4] 2> 5545118 T16836 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty1
[junit4] 2> 5545119 T16836 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty1/index/
[junit4] 2> 5545119 T16836 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty1/index' doesn't exist. Creating new
index...
[junit4] 2> 5545120 T16836 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty1/index
[junit4] 2> 5545120 T16836 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 5545121 T16836 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@fcef88a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d1f3421),segFN=segments_1,generation=1}
[junit4] 2> 5545122 T16836 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5545133 T16836 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5545134 T16836 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5545134 T16836 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5545135 T16836 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5545135 T16836 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5545135 T16836 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5545136 T16836 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5545136 T16836 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5545136 T16836 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5545138 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5545138 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5545139 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5545140 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 5545141 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 5545142 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 5545144 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 5545145 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 5545146 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 5545147 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 5545148 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 5545149 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 5545151 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 5545151 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 5545152 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 5545154 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 5545155 T16836 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 5545156 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 5545157 T16836 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 5545171 T16836 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5545173 T16836 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5545175 T16836 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5545179 T16836 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 5545182 T16836 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 5545184 T16836 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 5545185 T16836 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 5545188 T16836 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=16, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=61.015625,
floorSegmentMB=0.2666015625, forceMergeDeletesPctAllowed=10.085260096593478,
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 5545188 T16836 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@fcef88a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d1f3421),segFN=segments_1,generation=1}
[junit4] 2> 5545189 T16836 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5545190 T16836 oass.SolrIndexSearcher.<init> Opening
Searcher@7da7ad8e[collection1] main
[junit4] 2> 5545191 T16836 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5545195 T16836 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5545195 T16836 oasr.ManagedResourceStorage.newStorageIO
Setting up ZooKeeper-based storage for the RestManager with znodeBase:
/configs/conf1
[junit4] 2> 5545197 T16836
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 5545197 T16836 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 5545198 T16836 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5545199 T16836
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 5545200 T16836 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 5545200 T16836 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 5545201 T16836 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 5545202 T16837 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@7da7ad8e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 5545203 T16836 oasc.CoreContainer.registerCore registering
core: collection1
[junit4] 2> 5545206 T16840 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:60777 collection:collection1
shard:shard1
[junit4] 2> 5545207 T16779 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 5545209 T16779 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 5545210 T16840 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 5545224 T16840
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for
shard shard1
[junit4] 2> 5545229 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5545231 T16840
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found
to continue.
[junit4] 2> 5545231 T16840
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try
and sync
[junit4] 2> ASYNC NEW_CORE C5989 name=collection1
org.apache.solr.core.SolrCore@781149f url=http://127.0.0.1:60777/collection1
node=127.0.0.1:60777_ C5989_STATE=coll:collection1 core:collection1
props:{node_name=127.0.0.1:60777_, state=down, core=collection1,
base_url=http://127.0.0.1:60777}
[junit4] 2> 5545232 T16840 C5989 P60777 oasc.SyncStrategy.sync Sync
replicas to http://127.0.0.1:60777/collection1/
[junit4] 2> 5545232 T16840 C5989 P60777 oasc.SyncStrategy.syncReplicas
Sync Success - now sync replicas to me
[junit4] 2> 5545232 T16840 C5989 P60777 oasc.SyncStrategy.syncToMe
http://127.0.0.1:60777/collection1/ has no replicas
[junit4] 2> 5545233 T16840
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader:
http://127.0.0.1:60777/collection1/ shard1
[junit4] 2> 5545237 T16840 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard1
[junit4] 2> 5545238 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1"} current state version: 5
[junit4] 2> 5545241 T16806 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 1
[junit4] 2> 5545248 T16835 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 5545256 T16835 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 2
[junit4] 2> 5545270 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5545274 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:60777";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 5
[junit4] 2> 5545277 T16806 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 2
[junit4] 2> 5545281 T16835 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 5545287 T16835 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 3
[junit4] 2> 5545328 T16840 oasc.ZkController.register We are
http://127.0.0.1:60777/collection1/ and leader is
http://127.0.0.1:60777/collection1/
[junit4] 2> 5545330 T16840 oasc.ZkController.register No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:60777
[junit4] 2> 5545332 T16840 oasc.ZkController.checkRecovery I am the
leader, no recovery necessary
[junit4] 2> 5545333 T16840 oasc.ZkController.publish publishing
core=collection1 state=active collection=collection1
[junit4] 2> 5545333 T16840 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5545344 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5545348 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60777_",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60777"} current state
version: 5
[junit4] 2> 5545350 T16806 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60777_",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60777"}
[junit4] 2> 5545352 T16806 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 3
[junit4] 2> 5545355 T16835 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 5545365 T16840 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 5545366 T16835 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 4
[junit4] 2> 5547385 T16779 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 5547387 T16779 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 5547397 T16779 oejs.AbstractConnector.doStart Started
SelectChannelConnector@127.0.0.1:60780
[junit4] 2> 5547399 T16779 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@550a6723
[junit4] 2> 5547400 T16779 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 5547401 T16779 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004
[junit4] 2> 5547401 T16779 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004/'
[junit4] 2> 5547485 T16779 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004/solr.xml
[junit4] 2> 5547595 T16779 oasc.CoreContainer.<init> New CoreContainer
1037097026
[junit4] 2> 5547597 T16779 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004/]
[junit4] 2> 5547598 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 5547598 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 5547598 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 5547598 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 5547599 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 5547599 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 5547599 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 5547600 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 5547601 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 5547601 T16779 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 5547601 T16779 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 5547602 T16779 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5547602 T16779 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5547603 T16779 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 5547603 T16779 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60769/solr
[junit4] 2> 5547604 T16779 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 5547605 T16779
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 5547607 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5547615 T16852 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3c87390 name:ZooKeeperConnection
Watcher:127.0.0.1:60769 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 5547616 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5547616 T16779 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 5547623 T16779 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 5547628 T16855 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@437584b3
name:ZooKeeperConnection Watcher:127.0.0.1:60769/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 5547628 T16779 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 5547650 T16779
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 5548667 T16779 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60780_
[junit4] 2> 5548671 T16779 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60780_
[junit4] 2> 5548683 T16779 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 5548754 T16856 oasc.ZkController.publish publishing
core=collection1 state=down collection=collection1
[junit4] 2> 5548754 T16856 oasc.ZkController.publish numShards not found
on descriptor - reading it from system property
[junit4] 2> 5548762 T16805 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 5548767 T16806 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60780_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60780"} current state
version: 5
[junit4] 2> 5548771 T16806 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "numShards":"2",
[junit4] 2> "node_name":"127.0.0.1:60780_",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "operation":"state",
[junit4] 2> "base_url":"http://127.0.0.1:60780"}
[junit4] 2> 5548772 T16806 oasco.ReplicaMutator.updateState Collection
already exists with numShards=2
[junit4] 2> 5548773 T16806 oasco.ReplicaMutator.updateState Assigning new
node to shard shard=shard2
[junit4] 2> 5548776 T16856 oasc.ZkController.preRegister Registering watch
for external collection collection1
[junit4] 2> 5548777 T16856 oascc.ZkStateReader.addZkWatch addZkWatch
collection1
[junit4] 2> 5548781 T16806 oasco.ZkStateWriter.writePendingUpdates going
to update_collection /collections/collection1/state.json version: 4
[junit4] 2> 5548782 T16856 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/collection1/state.json from ZooKeeper...
[junit4] 2> 5548785 T16835 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json, has occurred - updating...
[junit4] 2> 5548788 T16835 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 5548792 T16856 oascc.ZkStateReader.updateWatchedCollection
Updating data for collection1 to ver 5
[junit4] 2> 5548793 T16856 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 5548794 T16856 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for collection1
[junit4] 2> 5548794 T16856 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:collection1
[junit4] 2> 5548799 T16856 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 5548799 T16856 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/collection1
[junit4] 2> 5548805 T16856 oascc.ZkStateReader.readConfigName
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 5548806 T16856 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004/collection1/'
[junit4] 2> 5548808 T16856 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-004/collection1/lib/.svn/'
to classloader
[junit4] 2> 5548809 T16856 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-004/collection1/lib/classes/'
to classloader
[junit4] 2> 5548810 T16856 oasc.SolrResourceLoader.replaceClassLoader
Adding
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading%205737A1E1DF90297E-001/tempDir-004/collection1/lib/README'
to classloader
[junit4] 2> 5548858 T16856 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 5548866 T16856 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 5548898 T16856 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 5548947 T16856 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 5549045 T16856 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 5549050 T16856 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 5549066 T16856 oass.IndexSchema.readSchema [collection1]
Schema name=test
[junit4] 2> 5549583 T16856 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 5549594 T16856 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 5549597 T16856 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 5549637 T16856 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5549645 T16856 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 5549651 T16856 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5549654 T16856
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5549654 T16856
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5549655 T16856 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 5549656 T16856
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 5549657 T16856
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 5549657 T16856 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from collection collection1
[junit4] 2> 5549657 T16856 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 5549658 T16856 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-004/collection1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty2/
[junit4] 2> 5549658 T16856 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5c769de6
[junit4] 2> 5549659 T16856 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty2
[junit4] 2> 5549659 T16856 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty2/index/
[junit4] 2> 5549659 T16856 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty2/index' doesn't exist. Creating new
index...
[junit4] 2> 5549660 T16856 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestDynamicLoading
5737A1E1DF90297E-001/tempDir-001/jetty2/index
[junit4] 2> 5549660 T16856 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 5549662 T16856 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@194c64b6
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6667f5b3),segFN=segments_1,generation=1}
[junit4] 2> 5549663 T16856 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 5549673 T16856 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 5549673 T16856 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 5549674 T16856 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 5549674 T16856 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 5549675 T16856 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 5549675 T16856 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 5549676 T16856 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 5549677 T16856 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 5549677 T16856 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 5549678 T16856 o
[...truncated too long message...]
st, TestFiltering, TestDefaultSimilarityFactory,
BinaryUpdateRequestHandlerTest, TestZkChroot, TestPhraseSuggestions,
DirectUpdateHandlerTest, TestFastWriter, TestTrie,
SimpleCollectionCreateDeleteTest, TestShardHandlerFactory,
TestReplicationHandlerBackup, BadComponentTest, TestSolrQueryParser,
SpellCheckCollatorTest, TestSolr4Spatial, SuggesterTest,
TestReplicationHandler, SOLR749Test, SuggesterWFSTTest,
TestCursorMarkWithoutUniqueKey, SuggestComponentTest, BlockCacheTest,
TestManagedStopFilterFactory, TestOverriddenPrefixQueryForCustomFieldType,
DistributedFacetPivotSmallTest, SolrPluginUtilsTest,
LegacyHTMLStripCharFilterTest, SolrCmdDistributorTest,
DistributedFacetPivotWhiteBoxTest, ZkCLITest, CoreMergeIndexesAdminHandlerTest,
DistributedDebugComponentTest, TermVectorComponentTest, SuggesterFSTTest,
ShowFileRequestHandlerTest, DateRangeFieldTest, DisMaxRequestHandlerTest,
TestTolerantSearch, TestCollapseQParserPlugin, TestConfig,
TestQuerySenderListener, DirectSolrConnectionTest, TestSolrXmlPersistence,
ExternalFileFieldSortTest, TestStressReorder,
DistributedQueryComponentOptimizationTest, TestInfoStreamLogging,
TestPostingsSolrHighlighter, CursorPagingTest, TestDFRSimilarityFactory,
EnumFieldTest, TestImplicitCoreProperties, DeleteShardTest, TestSchemaResource,
TestOrdValues, AsyncMigrateRouteKeyTest, TestBadConfig, SearchHandlerTest,
UUIDUpdateProcessorFallbackTest, ScriptEngineTest, RAMDirectoryFactoryTest,
FieldMutatingUpdateProcessorTest, TestComponentsName, TestQueryUtils,
TestIndexSearcher, FacetPivotSmallTest, TestLRUStatsCache, TestSolrJ,
DocExpirationUpdateProcessorFactoryTest, TestBulkSchemaAPI,
TestAtomicUpdateErrorCases, TestCollectionAPI,
OutOfBoxZkACLAndCredentialsProvidersTest, TestCustomSort,
TestSolrQueryParserDefaultOperatorResource, SimplePostToolTest,
TestNoOpRegenerator, CollectionsAPIAsyncDistributedZkTest, TestRestManager,
TestManagedResource, TestSchemaSimilarityResource,
CloudExitableDirectoryReaderTest, TestExpandComponent, TestIBSimilarityFactory,
TestArbitraryIndexDir, UpdateParamsTest, TestSystemIdResolver,
SynonymTokenizerTest, TestRealTimeGet, SolrIndexConfigTest,
TestLMDirichletSimilarityFactory, UnloadDistributedZkTest, ZkSolrClientTest,
TestManagedSchemaFieldTypeResource, SyncSliceTest,
CoreContainerCoreInitFailuresTest, SolrXmlInZkTest, TestDocSet,
HighlighterTest, TestSurroundQueryParser, SpellPossibilityIteratorTest,
TestNonDefinedSimilarityFactory, TestSolrDynamicMBean,
OverseerCollectionProcessorTest, CurrencyFieldOpenExchangeTest,
DistributedExpandComponentTest, SolrRequestParserTest, TestBinaryField,
TestBinaryResponseWriter, HttpPartitionTest, SliceStateTest, BJQParserTest,
AlternateDirectoryTest, UpdateRequestProcessorFactoryTest,
CollectionsAPIDistributedZkTest, WordBreakSolrSpellCheckerTest, PluginInfoTest,
ResponseHeaderTest, TestReload, TestSchemaNameResource,
TestBlendedInfixSuggestions, DebugComponentTest, ConvertedLegacyTest,
TestXIncludeConfig, TestQueryTypes, QueryParsingTest, TestAddFieldRealTimeGet,
SpellCheckComponentTest, TestSchemaManager, MBeansHandlerTest,
LeaderInitiatedRecoveryOnCommitTest, StandardRequestHandlerTest,
TestCloudManagedSchema, TestDynamicFieldResource, DocValuesTest,
HdfsChaosMonkeySafeLeaderTest, TestManagedSynonymFilterFactory,
TestStressLucene, RemoteQueryErrorTest,
DistribDocExpirationUpdateProcessorTest, TestSolrQueryParserResource,
JSONWriterTest, MergeStrategyTest, ExitableDirectoryReaderTest,
DefaultValueUpdateProcessorTest, TestCloudInspectUtil, ShardSplitTest,
TestPivotHelperCode, TestPHPSerializedResponseWriter,
TestDefaultSearchFieldResource, TestManagedSchema, TestCodecSupport,
TestDocumentBuilder, TestSolrDeletionPolicy2, QueryElevationComponentTest,
InfoHandlerTest, SpatialRPTFieldTypeTest, TestStressUserVersions,
TestFunctionQuery, MoreLikeThisHandlerTest, TestSolrXml,
PreAnalyzedUpdateProcessorTest, TestReRankQParserPlugin, DistanceFunctionTest,
TestFreeTextSuggestions, SolrInfoMBeanTest, TestValueSourceCache,
FieldAnalysisRequestHandlerTest, TestFuzzyAnalyzedSuggestions,
AnalysisErrorHandlingTest, AssignTest, ChangedSchemaMergeTest,
BasicDistributedZk2Test, StatsComponentTest, TestLuceneMatchVersion,
RequiredFieldsTest, TestDistributedGrouping, ReplicationFactorTest,
TestQuerySenderNoQuery, SchemaVersionSpecificBehaviorTest, ShardRoutingTest,
OverseerRolesTest, TestAnalyzeInfixSuggestions, TestJoin, PolyFieldTest,
CloudMLTQParserTest, TestSolrIndexConfig, TestExtendedDismaxParser,
TestRequestStatusCollectionAPI, ClusterStateTest, DocValuesMultiTest,
DocumentBuilderTest, AnalysisAfterCoreReloadTest, TestRandomMergePolicy,
SolrCoreCheckLockOnStartupTest, PingRequestHandlerTest, JsonLoaderTest,
SignatureUpdateProcessorFactoryTest, HdfsRecoveryZkTest,
BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, OpenCloseCoreStressTest,
OverseerTest, LeaderElectionIntegrationTest, BasicZkTest,
FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting,
LeaderElectionTest, ShardRoutingCustomTest, TestDistributedSearch,
AutoCommitTest, TestRecovery, TestHashPartitioner,
DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest,
ZkControllerTest, TestStressVersions, DistributedTermsComponentTest,
TestCoreContainer, SimpleFacetsTest, SolrCoreTest, TestGroupingSearch,
PeerSyncTest, BadIndexSchemaTest, BasicFunctionalityTest, TestLazyCores,
SoftAutoCommitTest, DistributedQueryElevationComponentTest,
CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery,
CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTSTTest,
SpatialFilterTest, TestCSVLoader, NoCacheHeaderTest, TestPseudoReturnFields,
TestUpdate, TestWordDelimiterFilterFactory, QueryEqualityTest,
DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest,
SortByFunctionTest, TestRemoteStreaming, TestSolrDeletionPolicy1,
CacheHeaderTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest,
TestWriterPerf, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory,
DocumentAnalysisRequestHandlerTest, PrimitiveFieldTypeTest, TestOmitPositions,
FileBasedSpellCheckerTest, TermsComponentTest, XmlUpdateRequestHandlerTest,
RequestHandlersTest, PathHierarchyTokenizerFactoryTest,
TestIndexingPerformance, FastVectorHighlighterTest,
IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest,
IndexSchemaTest, TestJmxIntegration, TestCollationField, ReturnFieldsTest,
TestCSVResponseWriter, TestAnalyzedSuggestions,
UniqFieldsUpdateProcessorFactoryTest, TestLFUCache, HighlighterConfigTest,
CopyFieldTest, TestStressRecovery, TestMergePolicyConfig, MultiTermTest,
SampleTest, TestSearchPerf, NumericFieldsTest, MinimalSchemaTest,
TestElisionMultitermQuery, OutputWriterTest, TestSolrCoreProperties,
NotRequiredUniqueKeyTest, TestCharFilters, EchoParamsTest,
TestSweetSpotSimilarityFactory, TestPerFieldSimilarity,
TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory,
TestJmxMonitoredMap, TimeZoneUtilsTest, ResourceLoaderTest,
TestFastOutputStream, OpenExchangeRatesOrgProviderTest,
URLClassifyProcessorTest, TestFastLRUCache, DateMathParserTest,
ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, PrimUtilsTest,
TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest,
DOMUtilTest, TestLRUCache, TestUtils, SystemInfoHandlerTest, UUIDFieldTest,
FileUtilsTest, TestRTGBase, DistributedIntervalFacetingTest,
SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping,
AliasIntegrationTest, ConnectionManagerTest, CustomCollectionTest,
DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest,
DeleteReplicaTest, DistribCursorPagingTest, ExternalCollectionsTest,
LeaderFailoverAfterPartitionTest, MigrateRouteKeyTest, MultiThreadedOCPTest,
OverriddenZkACLAndCredentialsProvidersTest, RollingRestartTest,
SSLMigrationTest, SharedFSAutoReplicaFailoverTest,
SharedFSAutoReplicaFailoverUtilsTest, TestCloudPivotFacet,
TestDistribDocBasedVersion, TestLeaderElectionZkExpiry,
TestMiniSolrCloudCluster, TestModifyConfFiles, TestReplicaProperties,
VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZk2Test,
HdfsBasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest,
HdfsSyncSliceTest, HdfsUnloadDistributedZkTest,
HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator,
ZkStateWriterTest, CachingDirectoryFactoryTest, QueryResultKeyTest,
TestConfigOverlay, TestConfigSets, TestDynamicLoading, TestInitParams,
TestNRTOpen, TestReloadAndDeleteDocs, TestSolrXmlPersistor, TestBlobHandler,
TestConfigReload, TestSolrConfigHandlerCloud]
[junit4] Completed in 61.00s, 1 test, 1 failure <<< FAILURES!
[...truncated 213 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:529: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:477: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:190: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:508: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1363:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:970:
There were test failures: 461 suites, 1869 tests, 2 failures, 52 ignored (21
assumptions)
Total time: 179 minutes 1 second
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0
-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
