Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1995/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC (asserts: false)
2 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
reload the collection time out:180s
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: reload
the collection time out:180s
at
__randomizedtesting.SeedInfo.seed([73CED626CBB727EE:F228583EBCE847D2]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:569)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
at
org.apache.solr.client.solrj.request.CollectionAdminRequest.process(CollectionAdminRequest.java:379)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testSolrJAPICalls(CollectionsAPIDistributedZkTest.java:332)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:201)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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.core.TestNonNRTOpen.testReaderIsNotNRT
Error Message:
SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@2d8f8f07
searcher=Searcher@5552bb29[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c1)
Uninverting(_2(6.0.0):c1)))} expected:<3> but was:<2>
Stack Trace:
java.lang.AssertionError: SOLR-5815? : wrong maxDoc:
core=org.apache.solr.core.SolrCore@2d8f8f07
searcher=Searcher@5552bb29[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c1)
Uninverting(_2(6.0.0):c1)))} expected:<3> but was:<2>
at
__randomizedtesting.SeedInfo.seed([73CED626CBB727EE:C648B7A17476951A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at
org.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:142)
at
org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:100)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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 8828 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/init-core-data-001
[junit4] 2> 427757 T1037 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 427757 T1037 oas.BaseDistributedSearchTestCase.initHostContext
Setting hostContext system property: /
[junit4] 2> 427765 T1037 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 427768 T1037 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 427769 T1038 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 427870 T1037 oasc.ZkTestServer.run start zk server on
port:49433
[junit4] 2> 427870 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 427871 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 427884 T1045 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@68799401
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 427885 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 427885 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 427886 T1037 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 427895 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 427896 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 427902 T1048 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5c67a692
name:ZooKeeperConnection Watcher:127.0.0.1:49433/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 427902 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 427903 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 427903 T1037 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 427910 T1037 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 427936 T1037 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 427949 T1037 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 427954 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 427955 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 427962 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 427963 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 427969 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 427969 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 427974 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 427975 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 427981 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 427981 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 427986 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 427986 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 427992 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 427992 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 427998 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 427999 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 428004 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 428004 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 428009 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 428009 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 428016 T1037 oasc.AbstractZkTestCase.putConfig put
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 428016 T1037 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> Using old style solr.xml
[junit4] 2> 429806 T1037 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 429814 T1037 oejs.AbstractConnector.doStart Started
[email protected]:49436
[junit4] 2> 429816 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 429817 T1037 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 429817 T1037 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002
[junit4] 2> 429818 T1037 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/'
[junit4] 2> 429871 T1037 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solr.xml
[junit4] 2> 429891 T1037 oasc.CoreContainer.<init> New CoreContainer
1298903117
[junit4] 2> 429900 T1037 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/]
[junit4] 2> 429901 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 429902 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 429902 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 429902 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 429902 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 429903 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 429903 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 429903 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 429903 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 429904 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 429905 T1037 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 429905 T1037 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 429905 T1037 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 429906 T1037 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 429923 T1037 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49433/solr
[junit4] 2> 429923 T1037 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 429923 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 429928 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 429933 T1060 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1fb9ab6f
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 429934 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 429934 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 429948 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 429951 T1063 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@8ac82d9 name:ZooKeeperConnection
Watcher:127.0.0.1:49433/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 429951 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 429954 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 429964 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 429977 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 429984 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 429992 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 429998 T1037 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 430001 T1037 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49436_
[junit4] 2> 430003 T1037 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49436_
[junit4] 2> 430015 T1037 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 430021 T1037 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 430026 T1037 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 430029 T1037 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:49436_
[junit4] 2> 430029 T1037 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 430036 T1037 oasc.Overseer.start Overseer
(id=92969693648715779-127.0.0.1:49436_-n_0000000000) starting
[junit4] 2> 430040 T1037 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 430068 T1037 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 430069 T1065 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 430074 T1037 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 430080 T1037 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 430083 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 430100 T1064 oasc.Overseer$ClusterStateUpdater.run Starting to
work on the main queue
[junit4] 2> 430105 T1037 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 430105 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 430105 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 430108 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 430111 T1070 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@39bfadea
name:ZooKeeperConnection Watcher:127.0.0.1:49433/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 430112 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 430112 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 430115 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 430126 T1037 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 431935 T1037 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 431935 T1037 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 431940 T1037 oejs.AbstractConnector.doStart Started
[email protected]:49440
[junit4] 2> 431941 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 431942 T1037 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 431942 T1037 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003
[junit4] 2> 431943 T1037 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/'
[junit4] 2> 431979 T1037 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solr.xml
[junit4] 2> 431996 T1037 oasc.CoreContainer.<init> New CoreContainer
1418433534
[junit4] 2> 431997 T1037 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/]
[junit4] 2> 431997 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 431998 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 431998 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 431998 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 431998 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 431998 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 431999 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 432000 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 432000 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 432000 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 432001 T1037 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 432001 T1037 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 432002 T1037 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 432002 T1037 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 432002 T1037 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49433/solr
[junit4] 2> 432003 T1037 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 432003 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 432005 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 432016 T1082 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2c6dfc61
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 432017 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 432017 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 432029 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 432035 T1085 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@b2cc37d name:ZooKeeperConnection
Watcher:127.0.0.1:49433/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 432036 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 432050 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 433063 T1037 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49440_
[junit4] 2> 433066 T1037 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49440_
[junit4] 2> 433078 T1037 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 433089 T1037 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 433089 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 434813 T1037 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 434814 T1037 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 434820 T1037 oejs.AbstractConnector.doStart Started
[email protected]:49443
[junit4] 2> 434820 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 434820 T1037 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 434821 T1037 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-004
[junit4] 2> 434821 T1037 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-004/'
[junit4] 2> 434869 T1037 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-004/solr.xml
[junit4] 2> 434886 T1037 oasc.CoreContainer.<init> New CoreContainer
751468938
[junit4] 2> 434887 T1037 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-004/]
[junit4] 2> 434887 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 434888 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 434888 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 434888 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 434889 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 434890 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 434890 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 434890 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 434890 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 434891 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 434892 T1037 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 434892 T1037 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 434892 T1037 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 434893 T1037 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 434893 T1037 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49433/solr
[junit4] 2> 434893 T1037 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 434894 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 434896 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 434907 T1098 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2a104c36
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 434910 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 434910 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 434916 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 434921 T1101 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5f698d88
name:ZooKeeperConnection Watcher:127.0.0.1:49433/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 434922 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 434944 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 435957 T1037 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49443_
[junit4] 2> 435960 T1037 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49443_
[junit4] 2> 435977 T1037 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 435988 T1037 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 435988 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 437765 T1037 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 437765 T1037 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 437770 T1037 oejs.AbstractConnector.doStart Started
[email protected]:49446
[junit4] 2> 437771 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 437771 T1037 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 437772 T1037 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005
[junit4] 2> 437772 T1037 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/'
[junit4] 2> 437813 T1037 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solr.xml
[junit4] 2> 437831 T1037 oasc.CoreContainer.<init> New CoreContainer
707917920
[junit4] 2> 437832 T1037 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/]
[junit4] 2> 437833 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 437833 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 437834 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 437834 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 437835 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 437835 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 437835 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 437836 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 437836 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 437836 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 437837 T1037 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 437838 T1037 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 437839 T1037 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 437839 T1037 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 437840 T1037 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49433/solr
[junit4] 2> 437840 T1037 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 437841 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 437842 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 437851 T1114 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7236d122
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 437852 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 437853 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 437861 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 437866 T1117 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@59d6983d
name:ZooKeeperConnection Watcher:127.0.0.1:49433/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 437867 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 437882 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 438893 T1037 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49446_
[junit4] 2> 438898 T1037 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49446_
[junit4] 2> 438920 T1037 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 438931 T1037 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 438931 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 440689 T1037 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 440690 T1037 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 440695 T1037 oejs.AbstractConnector.doStart Started
[email protected]:49449
[junit4] 2> 440697 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 440697 T1037 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 440698 T1037 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006
[junit4] 2> 440698 T1037 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/'
[junit4] 2> 440751 T1037 oasc.ConfigSolr.fromFile Loading container
configuration from
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solr.xml
[junit4] 2> 440766 T1037 oasc.CoreContainer.<init> New CoreContainer
644825401
[junit4] 2> 440767 T1037 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/]
[junit4] 2> 440767 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 440768 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 440768 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 440768 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 440768 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 440769 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 440769 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 440770 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 440770 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 440770 T1037 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 440771 T1037 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 440771 T1037 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 440772 T1037 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 440772 T1037 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 440772 T1037 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49433/solr
[junit4] 2> 440773 T1037 oasc.ZkController.checkChrootPath zkHost includes
chroot
[junit4] 2> 440773 T1037
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 440774 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 440780 T1130 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@200bfc09
name:ZooKeeperConnection Watcher:127.0.0.1:49433 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 440781 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 440781 T1037 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 440786 T1037 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 440790 T1133 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@65085a1a
name:ZooKeeperConnection Watcher:127.0.0.1:49433/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 440790 T1037 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 440808 T1037
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 441821 T1037 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49449_
[junit4] 2> 441823 T1037 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49449_
[junit4] 2> 441845 T1037 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 441862 T1037 oass.SolrDispatchFilter.init
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 441863 T1037 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 441879 T1078 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
replicationFactor=2&collection.configName=conf1&router.field=myOwnField&name=solrj_collection&action=CREATE&numShards=2&wt=javabin&version=2
[junit4] 2> 441881 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/collection-queue-work state
SyncConnected
[junit4] 2> 441884 T1065 oasc.OverseerCollectionProcessor.run Overseer
Collection Processor: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 441886 T1135 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"}
[junit4] 2> 441888 T1135 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 441889 T1135 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 441900 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 441913 T1064 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"solrj_collection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "router.field":"myOwnField"} current state version: 0
[junit4] 2> 441914 T1064 oasco.ClusterStateMutator.createCollection
building a new cName: solrj_collection
[junit4] 2> 441918 T1101 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 441918 T1063 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 441919 T1070 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 441919 T1117 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 441919 T1085 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 441920 T1133 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442101 T1135 oasc.OverseerCollectionProcessor.createCollection
Creating SolrCores for new collection solrj_collection, shardNames [shard1,
shard2] , replicationFactor : 2
[junit4] 2> 442101 T1135 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica1 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:49449_
[junit4] 2> 442111 T1135 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard1_replica2 as part of slice shard1 of
collection solrj_collection on 127.0.0.1:49446_
[junit4] 2> 442125 T1125 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard1_replica1&action=CREATE&numShards=2&collection=solrj_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 442127 T1135 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica1 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:49436_
[junit4] 2> 442132 T1110 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard1_replica2&action=CREATE&numShards=2&collection=solrj_collection&shard=shard1&wt=javabin&version=2
[junit4] 2> 442133 T1125 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 442134 T1135 oasc.OverseerCollectionProcessor.createCollection
Creating shard solrj_collection_shard2_replica2 as part of slice shard2 of
collection solrj_collection on 127.0.0.1:49440_
[junit4] 2> 442137 T1057 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard2_replica1&action=CREATE&numShards=2&collection=solrj_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 442138 T1125 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 442139 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 442142 T1074 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=solrj_collection_shard2_replica2&action=CREATE&numShards=2&collection=solrj_collection&shard=shard2&wt=javabin&version=2
[junit4] 2> 442143 T1110 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 442146 T1057 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 442146 T1064 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49449";,
[junit4] 2> "node_name":"127.0.0.1:49449_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 442147 T1110 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 442148 T1057 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 442148 T1074 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 442150 T1064 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49449";,
[junit4] 2> "node_name":"127.0.0.1:49449_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 442152 T1074 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 442161 T1064 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 3, message = {
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49446";,
[junit4] 2> "node_name":"127.0.0.1:49446_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 442163 T1064 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49446";,
[junit4] 2> "node_name":"127.0.0.1:49446_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 442169 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 442172 T1064 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49436";,
[junit4] 2> "node_name":"127.0.0.1:49436_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 442174 T1064 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49436";,
[junit4] 2> "node_name":"127.0.0.1:49436_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 442179 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 442181 T1064 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49440";,
[junit4] 2> "node_name":"127.0.0.1:49440_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 442183 T1064 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"solrj_collection_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:49440";,
[junit4] 2> "node_name":"127.0.0.1:49440_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 442190 T1063 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 442299 T1101 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442300 T1085 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442301 T1070 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442302 T1117 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442302 T1133 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 442303 T1063 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 443139 T1125 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 443139 T1125 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 443140 T1125 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 443140 T1125 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 443143 T1125 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 443143 T1125 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/'
[junit4] 2> 443148 T1110 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 443149 T1110 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 443149 T1057 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 443151 T1057 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 443153 T1074 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 443153 T1074 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 443157 T1074 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 443157 T1074 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 443158 T1057 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 443158 T1057 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 443159 T1110 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 443159 T1110 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 443163 T1110 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 443163 T1110 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/'
[junit4] 2> 443168 T1074 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 443169 T1074 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/'
[junit4] 2> 443190 T1125 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 443192 T1110 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 443197 T1074 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 443201 T1057 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 443201 T1057 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/'
[junit4] 2> 443204 T1125 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 443222 T1110 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 443225 T1074 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 443232 T1057 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 443247 T1125 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 443245 T1110 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 443285 T1074 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 443297 T1110 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 443300 T1074 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 443306 T1125 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 443309 T1110 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 443311 T1125 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 443314 T1057 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 443317 T1125 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 443319 T1074 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 443327 T1074 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 443344 T1110 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 443383 T1057 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 443395 T1057 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 443407 T1057 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 443432 T1057 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 443693 T1125 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 443749 T1110 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 443758 T1110 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 443759 T1125 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 443760 T1110 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 443760 T1125 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 443828 T1074 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 443832 T1074 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 443844 T1074 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 443851 T1057 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 443856 T1057 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 443866 T1057 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 443861 T1110 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443875 T1110 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443882 T1110 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443887 T1125 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443890 T1110
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443899 T1110
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443899 T1110 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443895 T1125 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443908 T1125 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443910 T1110
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443911 T1110
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443914 T1125
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443915 T1125
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443916 T1125 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443916 T1110 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 443917 T1110 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 443917 T1110 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/data/
[junit4] 2> 443918 T1110 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@47699f89
[junit4] 2> 443919 T1110 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/data
[junit4] 2> 443919 T1110 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/data/index/
[junit4] 2> 443919 T1110 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 443920 T1110 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-005/solrj_collection_shard1_replica2/data/index
[junit4] 2> 443921 T1110 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=39.142578125,
floorSegmentMB=2.1845703125, forceMergeDeletesPctAllowed=10.145108868489412,
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.11121474678535614
[junit4] 2> 443922 T1125
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443923 T1125
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443923 T1125 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 443923 T1125 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 443924 T1125 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/data/
[junit4] 2> 443924 T1125 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@47699f89
[junit4] 2> 443925 T1125 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/data
[junit4] 2> 443926 T1125 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/data/index/
[junit4] 2> 443926 T1125 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 443927 T1125 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-006/solrj_collection_shard1_replica1/data/index
[junit4] 2> 443927 T1125 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=39.142578125,
floorSegmentMB=2.1845703125, forceMergeDeletesPctAllowed=10.145108868489412,
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.11121474678535614
[junit4] 2> 443937 T1074 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443949 T1074 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443954 T1074 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443958 T1074
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443958 T1074
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443958 T1074 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443968 T1074
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443969 T1074
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443970 T1074 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 443970 T1074 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 443970 T1074 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/data/
[junit4] 2> 443971 T1074 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@47699f89
[junit4] 2> 443972 T1074 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/data
[junit4] 2> 443972 T1074 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/data/index/
[junit4] 2> 443973 T1074 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/data/index'
doesn't exist. Creating new index...
[junit4] 2> 443973 T1074 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-003/solrj_collection_shard2_replica2/data/index
[junit4] 2> 443973 T1074 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=39.142578125,
floorSegmentMB=2.1845703125, forceMergeDeletesPctAllowed=10.145108868489412,
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.11121474678535614
[junit4] 2> 443977 T1057 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443985 T1057 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 443990 T1057 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443993 T1057
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 443993 T1057
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 443994 T1057 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 443994 T1110 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@6ca80d60
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10f84c00),segFN=segments_1,generation=1}
[junit4] 2> 443995 T1110 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 443998 T1125 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@59651586
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@dd653fb),segFN=segments_1,generation=1}
[junit4] 2> 443998 T1125 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 444002 T1074 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@2a6e720b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@21a40649),segFN=segments_1,generation=1}
[junit4] 2> 444003 T1057
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 444006 T1057
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 444007 T1057 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 444007 T1110 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 444007 T1057 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 444010 T1057 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/,
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/data/
[junit4] 2> 444011 T1057 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@47699f89
[junit4] 2> 444012 T1110 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 444013 T1110 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 444013 T1110 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 444014 T1110 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 444014 T1110 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 444007 T1074 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 444015 T1110 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 444014 T1057 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/data
[junit4] 2> 444016 T1110 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 444018 T1110 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 444017 T1057 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/data/index/
[junit4] 2> 444019 T1057 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 444020 T1057 oasc.CachingDirectoryFactory.get return new
directory for
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPIDistributedZkTest-73CED626CBB727EE-001/tempDir-002/solrj_collection_shard2_replica1/data/index
[junit4] 2> 444020 T1057 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=39.142578125,
floorSegmentMB=2.1845703125, forceMergeDeletesPctAllowed=10.145108868489412,
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.11121474678535614
[junit4] 2> 444022 T1125 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 444023 T1125 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 444023 T1125 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 444023 T1125 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 444024 T1125 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 444024 T1125 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 444025 T1125 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 444025 T1125 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 444025 T1125 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 444022 T1074 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 444029 T1074 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 444030 T1074 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 444030 T1074 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 444031 T1074 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 444031 T1074 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 444032 T1074 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 444032 T1074 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 444032 T1074 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 444038 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444038 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444039 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444040 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444040 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444041 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 444042 T1074 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 444042 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444044 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444045 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 444045 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 444046 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 444046 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 444047 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 444048 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 444050 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 444051 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 444051 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 444052 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 444053 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 444053 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 444054 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 444054 T1110 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 444055 T1110 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 444056 T1110 oasc.RequestHandlers.initHand
[...truncated too long message...]
585 T11214 oasc.SolrCore.registerSearcher [collection1] Registered new searcher
Searcher@82e2bac[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):c1)
Uninverting(_5(6.0.0):c1) Uninverting(_6(6.0.0):c2/1:delGen=1)))}
[junit4] 2> 3504586 T11206 C3314 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 3504586 T11206 C3314 oasup.LogUpdateProcessor.finish
[collection1] webapp=null path=null params={} {commit=} 0 23
[junit4] 2> 3504587 T11206 oas.SolrTestCaseJ4.tearDown ###Ending
testSharedCores
[junit4] 2> 3504589 T11206 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 3504590 T11206 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=2031302243
[junit4] 2> 3504590 T11206 oasc.SolrCore.close [collection1] CLOSING
SolrCore org.apache.solr.core.SolrCore@2d8f8f07
[junit4] 2> 3504591 T11206 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=4,autocommits=0,soft
autocommits=0,optimizes=1,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
[junit4] 2> 3504591 T11206 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 3504591 T11206 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 3504592 T11206 oasu.DefaultSolrCoreState.closeIndexWriter
closing IndexWriter with IndexWriterCloser
[junit4] 2> 3504594 T11206 oasc.SolrCore.closeSearcher [collection1]
Closing main searcher on request.
[junit4] 2> 3504594 T11206 oasc.CachingDirectoryFactory.close Closing
StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 3504594 T11206 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001/index;done=false>>]
[junit4] 2> 3504595 T11206 oasc.CachingDirectoryFactory.close Closing
directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001/index
[junit4] 2> 3504595 T11206 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001;done=false>>]
[junit4] 2> 3504595 T11206 oasc.CachingDirectoryFactory.close Closing
directory:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-73CED626CBB727EE-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{bazz=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
foo=FSTOrd50,
baz=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
foo2=PostingsFormat(name=Memory doPackFST= false)}, docValues:{},
sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=el,
timezone=Atlantic/Bermuda
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_20
(64-bit)/cpus=2,threads=1,free=219852984,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [FastVectorHighlighterTest,
EnumFieldTest, RecoveryZkTest, TestStressUserVersions, MultiTermTest,
TestFaceting, DistributedSuggestComponentTest, ExternalCollectionsTest,
QueryResultKeyTest, TestRTGBase, TestSolrCoreProperties, SynonymTokenizerTest,
DistributedFacetPivotSmallTest, DistributedFacetPivotLongTailTest,
TestFastLRUCache, TermVectorComponentDistributedTest,
StatelessScriptUpdateProcessorFactoryTest, SpellPossibilityIteratorTest,
NumericFieldsTest, DistributedFacetPivotSmallAdvancedTest,
TestManagedResourceStorage, StandardRequestHandlerTest,
DirectUpdateHandlerTest, TestShortCircuitedRequests,
SpellingQueryConverterTest, CollectionsAPIDistributedZkTest,
BasicDistributedZkTest, XsltUpdateRequestHandlerTest,
TestCloudManagedSchemaConcurrent, AssignTest,
CoreContainerCoreInitFailuresTest, SuggesterTSTTest, PrimitiveFieldTypeTest,
TestArbitraryIndexDir, TimeZoneUtilsTest, AnalyticsMergeStrategyTest,
MergeStrategyTest, TestSerializedLuceneMatchVersion, ShardRoutingCustomTest,
TestUtils, TestSolr4Spatial2, TestExtendedDismaxParser,
HdfsChaosMonkeySafeLeaderTest, QueryParsingTest, PeerSyncTest,
TestCloudPivotFacet, ReturnFieldsTest, SpellCheckCollatorTest, SliceStateTest,
CoreAdminRequestStatusTest, SolrIndexSplitterTest, TestConfig,
DistributedSpellCheckComponentTest, DistributedQueryElevationComponentTest,
QueryEqualityTest, ResponseLogComponentTest, HdfsBasicDistributedZkTest,
TestRandomMergePolicy, TestHighlightDedupGrouping, TestReplicationHandler,
TestRestManager, TestExpandComponent, ConnectionManagerTest, SuggesterWFSTTest,
TestCollapseQParserPlugin, TestCSVLoader, DocValuesTest, TestConfigReload,
TestPerFieldSimilarity, DeleteInactiveReplicaTest,
OpenExchangeRatesOrgProviderTest, HighlighterConfigTest, TestSearcherReuse,
TestPhraseSuggestions, TestDynamicFieldResource,
LeaderInitiatedRecoveryOnCommitTest, DistributedFacetPivotLargeTest,
CurrencyFieldOpenExchangeTest, TestImplicitCoreProperties, TestLazyCores,
DirectSolrSpellCheckerTest, TestManagedSchemaDynamicFieldResource,
DistributedQueueTest, HdfsBasicDistributedZk2Test,
DirectUpdateHandlerOptimizeTest, SuggestComponentTest,
DisMaxRequestHandlerTest, TestQuerySenderNoQuery, TestFreeTextSuggestions,
SchemaVersionSpecificBehaviorTest, StatsComponentTest,
TestPHPSerializedResponseWriter, TestCursorMarkWithoutUniqueKey,
UniqFieldsUpdateProcessorFactoryTest, HdfsCollectionsAPIDistributedZkTest,
SharedFSAutoReplicaFailoverTest, CollectionsAPIAsyncDistributedZkTest,
TestUniqueKeyFieldResource, SyncSliceTest, TestFastOutputStream,
UUIDUpdateProcessorFallbackTest, HighlighterMaxOffsetTest,
DefaultValueUpdateProcessorTest, ShardSplitTest, TestCloudManagedSchema,
TestBadConfig, TestCodecSupport, TestLRUCache, EchoParamsTest,
TestOmitPositions, PolyFieldTest, CustomCollectionTest, TestPseudoReturnFields,
DateMathParserTest, TestPostingsSolrHighlighter, TestSchemaSimilarityResource,
HdfsDirectoryTest, RemoteQueryErrorTest, TestReplicationHandlerBackup,
TestIndexingPerformance, TestInitParams, BJQParserTest,
ExitableDirectoryReaderTest, TestFoldingMultitermQuery, TestCSVResponseWriter,
TestManagedStopFilterFactory, TestFieldCollectionResource, TestBinaryField,
ChaosMonkeyNothingIsSafeTest, TestSuggestSpellingConverter,
TestAnalyzeInfixSuggestions, OverseerRolesTest, CursorMarkTest, TestRecovery,
TestRecoveryHdfs, IndexSchemaTest, TestDefaultSearchFieldResource,
TestShardHandlerFactory, TestConfigOverlay, TestRandomDVFaceting,
WordBreakSolrSpellCheckerTest, JSONWriterTest, SolrCoreTest,
DistributedQueryComponentOptimizationTest, TestStressVersions,
CSVRequestHandlerTest, SharedFSAutoReplicaFailoverUtilsTest,
DistributedDebugComponentTest, TestElisionMultitermQuery,
TestSweetSpotSimilarityFactory, TestSortingResponseWriter, HighlighterTest,
IndexBasedSpellCheckerTest, TestFuzzyAnalyzedSuggestions, InfoHandlerTest,
TestSolrJ, OutOfBoxZkACLAndCredentialsProvidersTest, ConvertedLegacyTest,
TestDistributedMissingSort, TestLMDirichletSimilarityFactory,
DistributedIntervalFacetingTest, CurrencyFieldXmlFileTest,
DistributedQueryComponentCustomSortTest, TestSurroundQueryParser,
TestFieldResource, ExternalFileFieldSortTest, TestJmxIntegration,
OverseerStatusTest, LoggingHandlerTest, TestRawResponseWriter, TestQueryUtils,
TestBulkSchemaAPI, BadCopyFieldTest, TestFieldTypeResource, SolrXmlInZkTest,
TestMaxScoreQueryParser, TestManagedSchemaFieldTypeResource,
DocValuesMissingTest, LukeRequestHandlerTest,
DistribDocExpirationUpdateProcessorTest, TestNRTOpen,
IndexSchemaRuntimeFieldTest, TestSchemaManager, DeleteShardTest, TestNonNRTOpen]
[junit4] Completed in 1.22s, 2 tests, 1 failure <<< FAILURES!
[...truncated 815 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:519: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:467: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:187: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:510:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1349:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:956:
There were test failures: 452 suites, 1845 tests, 1 error, 1 failure, 37
ignored (21 assumptions)
Total time: 155 minutes 19 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0
-XX:+UseCompressedOops -XX:+UseG1GC (asserts: false)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
