Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4354/
Java: 32bit/jdk1.8.0_40-ea-b04 -server -XX:+UseParallelGC
1 tests failed.
REGRESSION:
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testDistribSearch
Error Message:
Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create
core [halfcollection_shard1_replica1] Caused by: Could not get shard id for
core: halfcollection_shard1_replica1
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: Could not get shard id for core:
halfcollection_shard1_replica1
at
__randomizedtesting.SeedInfo.seed([35C691C0BDEDB058:B4201FD8CAB2D064]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
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.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
at sun.reflect.GeneratedMethodAccessor54.invoke(Unknown Source)
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:43)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11526 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\init-core-data-001
[junit4] 2> 3521013 T9981 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (true)
[junit4] 2> 3521013 T9981
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 3521020 T9981 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 3521021 T9981 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3521022 T9982 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 3521162 T9981 oasc.ZkTestServer.run start zk server on
port:60745
[junit4] 2> 3521166 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3521171 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3521177 T9988 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1f8df37 name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3521177 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3521177 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3521177 T9981 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3521187 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3521190 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3521191 T9990 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@13f64ad name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3521193 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3521193 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3521193 T9981 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 3521199 T9981 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 3521204 T9981 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 3521208 T9981 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 3521213 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 3521215 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 3521227 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 3521227 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 3521236 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3521238 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3521246 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 3521246 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 3521254 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 3521254 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 3521261 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 3521261 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 3521267 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 3521267 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 3521274 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 3521275 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 3521279 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3521280 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3521285 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 3521286 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 3521291 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 3521291 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> Using old style solr.xml
[junit4] 2> 3521300 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3521302 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3521304 T9992 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@11b3aca name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3521305 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3521305 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3521305 T9981 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3521309 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3521312 T9983 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x148de0519ff0002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3521317 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3521320 T9994 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@193fed2 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3521320 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3521322 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3521323 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 3521324 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.xml
[junit4] 2> 3521331 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 3521333 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/schema.xml
[junit4] 2> 3521339 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3521339 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3521346 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 3521346 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/stopwords.txt
[junit4] 2> 3521352 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 3521352 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/protwords.txt
[junit4] 2> 3521359 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 3521359 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/currency.xml
[junit4] 2> 3521364 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 3521364 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/open-exchange-rates.json
[junit4] 2> 3521370 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 3521370 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 3521375 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 3521375 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/old_synonyms.txt
[junit4] 2> 3521381 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 3521381 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/synonyms.txt
[junit4] 2> 3521386 T9981 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 3521386 T9981 oascc.SolrZkClient.makePath makePath:
/configs/conf2/elevate.xml
[junit4] 2> 3524378 T9981 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3524416 T9981 oejs.AbstractConnector.doStart Started
[email protected]:60758
[junit4] 2> 3524417 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3524417 T9981 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3524417 T9981 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002
[junit4] 2> 3524419 T9981 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\'
[junit4] 2> 3524477 T9981 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\solr.xml
[junit4] 2> 3524501 T9981 oasc.CoreContainer.<init> New CoreContainer
24339068
[junit4] 2> 3524501 T9981 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\]
[junit4] 2> 3524503 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 3524503 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 3524504 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3524504 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3524504 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3524505 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3524505 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3524505 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3524507 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3524507 T9981 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 3524507 T9981 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3524508 T9981 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3524508 T9981 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3524509 T9981 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60745/solr
[junit4] 2> 3524509 T9981 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3524509 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3524512 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3524515 T10005 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@17d95d4 name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3524516 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3524516 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3524522 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3524523 T10007 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@ace800 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3524525 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3524526 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 3524533 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 3524538 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 3524544 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 3524551 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 3524556 T9981 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 3524559 T9981 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60758_
[junit4] 2> 3524560 T9981 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60758_
[junit4] 2> 3524570 T9981 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 3524573 T9981 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 3524577 T9981 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3524579 T9981 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:60758_
[junit4] 2> 3524581 T9981 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 3524585 T9981 oasc.Overseer.start Overseer
(id=92567905853440005-127.0.0.1:60758_-n_0000000000) starting
[junit4] 2> 3524589 T9981 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 3524606 T9981 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 3524607 T10009 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 3524608 T9981 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 3524612 T9981 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 3524615 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3524623 T10008 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 3524625 T9981 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3524626 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3524628 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3524629 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3524632 T10013 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f3ded5 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3524632 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3524632 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3524634 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3524643 T9981 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 3524643 T9981 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 3524643 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3524647 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3524650 T10015 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@453775 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3524650 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3524650 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3524656 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3524666 T10008
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
collection1
[junit4] 2> 3524667 T10008
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 3524667 T10008
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
[junit4] 2> 3524673 T10008
oasc.Overseer$ClusterStateUpdater.updateZkStates going to create_collection
/collections/collection1/state.json
[junit4] 2> 3524677 T10016 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 3524688 T10017 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 3527339 T9981 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 3527340 T9981 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3527347 T9981 oejs.AbstractConnector.doStart Started
[email protected]:60773
[junit4] 2> 3527350 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3527350 T9981 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3527351 T9981 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-003
[junit4] 2> 3527351 T9981 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-003\'
[junit4] 2> 3527405 T9981 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-003\solr.xml
[junit4] 2> 3527431 T9981 oasc.CoreContainer.<init> New CoreContainer
5881953
[junit4] 2> 3527431 T9981 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-003\]
[junit4] 2> 3527434 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 3527434 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 3527435 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3527435 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3527435 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3527435 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3527438 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3527438 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3527438 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3527438 T9981 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 3527438 T9981 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3527438 T9981 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3527441 T9981 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3527441 T9981 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60745/solr
[junit4] 2> 3527441 T9981 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3527441 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3527446 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3527450 T10028 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1c0687b name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3527450 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3527452 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3527454 T9983 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x148de0519ff0008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3527457 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3527461 T10030 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@299f9a name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3527463 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3527479 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3528840 T9981 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60773_
[junit4] 2> 3528841 T9981 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60773_
[junit4] 2> 3528850 T9981 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3528859 T9981 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3528859 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3531198 T9981 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 3531199 T9981 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3531206 T9981 oejs.AbstractConnector.doStart Started
[email protected]:60782
[junit4] 2> 3531208 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3531208 T9981 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3531209 T9981 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004
[junit4] 2> 3531210 T9981 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\'
[junit4] 2> 3531263 T9981 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solr.xml
[junit4] 2> 3531279 T9981 oasc.CoreContainer.<init> New CoreContainer
847623
[junit4] 2> 3531281 T9981 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\]
[junit4] 2> 3531281 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 3531282 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 3531282 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3531282 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3531283 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3531283 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3531283 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3531284 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3531284 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3531286 T9981 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 3531286 T9981 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3531286 T9981 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3531287 T9981 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3531287 T9981 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60745/solr
[junit4] 2> 3531287 T9981 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3531288 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3531290 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3531292 T10043 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1101c9d name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3531293 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3531293 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3531297 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3531298 T10045 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@186e34 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3531299 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3531310 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3532585 T9981 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60782_
[junit4] 2> 3532587 T9981 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60782_
[junit4] 2> 3532597 T9981 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3532603 T9981 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3532603 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3534888 T9981 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 3534889 T9981 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3534895 T9981 oejs.AbstractConnector.doStart Started
[email protected]:60791
[junit4] 2> 3534896 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3534897 T9981 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3534897 T9981 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005
[junit4] 2> 3534899 T9981 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\'
[junit4] 2> 3534951 T9981 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solr.xml
[junit4] 2> 3534986 T9981 oasc.CoreContainer.<init> New CoreContainer
1304946
[junit4] 2> 3534986 T9981 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\]
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3534990 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3534990 T9981 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 3534994 T9981 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3534994 T9981 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3534994 T9981 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3534994 T9981 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60745/solr
[junit4] 2> 3534994 T9981 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3534994 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3535001 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3535005 T10058 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4eca20 name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3535005 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3535006 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3535014 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3535017 T10060 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@47bf9 name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3535017 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3535031 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3536310 T9981 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60791_
[junit4] 2> 3536314 T9981 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60791_
[junit4] 2> 3536333 T9981 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3536343 T9981 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3536343 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3538694 T9981 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 3538695 T9981 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3538700 T9981 oejs.AbstractConnector.doStart Started
[email protected]:60800
[junit4] 2> 3538702 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 3538703 T9981 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 3538703 T9981 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006
[junit4] 2> 3538705 T9981 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\'
[junit4] 2> 3538748 T9981 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solr.xml
[junit4] 2> 3538764 T9981 oasc.CoreContainer.<init> New CoreContainer
9083530
[junit4] 2> 3538764 T9981 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\]
[junit4] 2> 3538766 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 120000
[junit4] 2> 3538766 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to: null
[junit4] 2> 3538766 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 3538768 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 3538768 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 3538768 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 3538769 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 3538769 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 3538770 T9981 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 3538770 T9981 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=3400000&connTimeout=45000&retry=false
[junit4] 2> 3538771 T9981 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3538771 T9981 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3538771 T9981 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3538773 T9981 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:60745/solr
[junit4] 2> 3538773 T9981 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 3538774 T9981
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 3538775 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3538778 T10073 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@f73f70 name:ZooKeeperConnection
Watcher:127.0.0.1:60745 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 3538778 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3538779 T9981 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 3538782 T9981 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 3538784 T10075 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5e790c name:ZooKeeperConnection
Watcher:127.0.0.1:60745/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 3538785 T9981 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 3538796 T9981
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 3540071 T9981 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60800_
[junit4] 2> 3540073 T9981 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:60800_
[junit4] 2> 3540085 T9981 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 3540091 T9981 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3540091 T9981 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 3540097 T10022 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> 3540099 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 3540101 T10009 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> 3540102 T10078 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> 3540106 T10078 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 3540106 T10078 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 3540113 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3540122 T10008
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
solrj_collection
[junit4] 2> 3540122 T10008
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 3540122 T10008
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 3540127 T10017 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> 3540127 T10076 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> 3540127 T10031 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> 3540128 T10046 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> 3540127 T10061 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> 3540129 T10016 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> 3540242 T10078
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 3540242 T10078
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:60758_
[junit4] 2> 3540244 T10078
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:60800_
[junit4] 2> 3540246 T10078
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:60791_
[junit4] 2> 3540247 T9998 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> 3540249 T10069 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> 3540251 T10078
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:60782_
[junit4] 2> 3540254 T9998 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 3540257 T10055 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> 3540258 T10041 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> 3540259 T9998 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3540259 T10069 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 3540260 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3540262 T10069 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3540262 T10055 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 3540263 T10041 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 3540265 T10055 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3540267 T10041 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 3540270 T10008 oasc.Overseer$ClusterStateUpdater.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:60758";,
[junit4] 2> "node_name":"127.0.0.1:60758_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3540276 T10008 oasc.Overseer$ClusterStateUpdater.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:60800";,
[junit4] 2> "node_name":"127.0.0.1:60800_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3540280 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3540283 T10008 oasc.Overseer$ClusterStateUpdater.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:60791";,
[junit4] 2> "node_name":"127.0.0.1:60791_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3540286 T10016 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 3540288 T10008 oasc.Overseer$ClusterStateUpdater.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:60782";,
[junit4] 2> "node_name":"127.0.0.1:60782_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 3540421 T10061 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> 3540421 T10017 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> 3540421 T10031 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> 3540421 T10046 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> 3540421 T10016 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> 3540421 T10076 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> 3541465 T9998 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 3541465 T9998 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3541467 T9998 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3541467 T9998 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3541468 T10069 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 3541468 T10069 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3541470 T10055 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 3541470 T10055 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3541472 T10041 oasc.ZkController.waitForShardId waiting to
find shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 3541473 T10041 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 3541472 T9998 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3541475 T10055 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3541472 T10069 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3541476 T10069 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3541475 T10055 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3541475 T9998 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\solrj_collection_shard1_replica1\'
[junit4] 2> 3541476 T10041 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 3541478 T10041 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3541483 T10069 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3541484 T10069 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\'
[junit4] 2> 3541495 T10055 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3541495 T10055 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\'
[junit4] 2> 3541496 T10041 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 3541497 T10041 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\'
[junit4] 2> 3541566 T9998 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3541583 T9998 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3541589 T10041 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3541600 T10069 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3541604 T10041 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3541615 T10069 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3541618 T9998 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3541648 T10055 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 3541648 T9998 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 3541663 T10055 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 3541665 T10041 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3541675 T10041 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 3541746 T10055 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3541757 T10055 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 3541814 T9998 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3541823 T9998 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 3541825 T9998 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3541863 T10069 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 3541872 T10069 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 3541916 T10055 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3541922 T10055 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3541924 T10055 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3541997 T10069 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3541999 T10041 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3542001 T10069 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3542002 T10041 oass.IndexSchema.readSchema default search
field in schema is text
[junit4] 2> 3542002 T10069 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3542002 T10041 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3542033 T10041 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542038 T9998 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542040 T10041 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542043 T9998 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542044 T10041 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542044 T10069 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542045 T10055 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542048 T10041
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542052 T10041
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542052 T10041 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542054 T9998 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542054 T10069 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542058 T10041
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542058 T10041
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542058 T10041 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 3542058 T10041 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3542059 T10041 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\data\
[junit4] 2> 3542060 T10041 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@19028
[junit4] 2> 3542060 T9998
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542060 T9998
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542060 T10041 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\data\
[junit4] 2> 3542059 T10055 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 3542060 T9998 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542061 T10041 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\data\index/
[junit4] 2> 3542062 T10041 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 3542063 T10041 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-004\solrj_collection_shard2_replica2\data\index
[junit4] 2> 3542063 T10041 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=38, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=1.4404296875,
floorSegmentMB=0.703125, forceMergeDeletesPctAllowed=22.45054876096744,
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.2249908444663974
[junit4] 2> 3542064 T10069 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542069 T9998
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542069 T9998
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542069 T9998 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 3542069 T9998 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3542070 T9998 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\solrj_collection_shard1_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\solrj_collection_shard1_replica1\data\
[junit4] 2> 3542070 T9998 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@19028
[junit4] 2> 3542070 T10041 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-865b70)),segFN=segments_1,generation=1}
[junit4] 2> 3542070 T10041 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3542070 T10055 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542071 T9998 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-002\solrj_collection_shard1_replica1\data\
[junit4] 2> 3542070 T10069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542073 T10069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542073 T10069 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542075 T10041 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3542077 T10041 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3542077 T10041 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3542078 T10041 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3542078 T10041 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3542079 T10041 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3542079 T10041 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3542080 T10041 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3542080 T10041 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3542080 T10041 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542081 T10041 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542081 T10041 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542082 T10041 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3542082 T10041 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 3542082 T10041 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3542083 T10041 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 3542079 T10069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542102 T10069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542102 T10069 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 3542102 T10069 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3542104 T10069 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\data\
[junit4] 2> 3542106 T10069 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@19028
[junit4] 2> 3542107 T10069 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\data\
[junit4] 2> 3542079 T10055
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542108 T10055
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542108 T10055 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3542110 T10069 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\data\index/
[junit4] 2> 3542110 T10069 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 3542111 T10069 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-006\solrj_collection_shard1_replica2\data\index
[junit4] 2> 3542112 T10069 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=38, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=1.4404296875,
floorSegmentMB=0.703125, forceMergeDeletesPctAllowed=22.45054876096744,
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.2249908444663974
[junit4] 2> 3542113 T10069 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-5b13a9)),segFN=segments_1,generation=1}
[junit4] 2> 3542113 T10069 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3542119 T10069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3542120 T10069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3542120 T10069 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3542121 T10069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3542121 T10069 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3542121 T10069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3542122 T10069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3542123 T10069 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3542123 T10069 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3542124 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542124 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542126 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542127 T10069 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3542128 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 3542128 T10069 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3542128 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 3542129 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 3542129 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3542130 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3542130 T10069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3542137 T10069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542139 T10069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542141 T10069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542142 T10069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542146 T10069 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3542146 T10069 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3542148 T10069 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=48, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=96.25,
floorSegmentMB=1.1533203125, forceMergeDeletesPctAllowed=15.87222114473133,
segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 3542149 T10069 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-5b13a9)),segFN=segments_1,generation=1}
[junit4] 2> 3542149 T10069 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3542149 T10069 oass.SolrIndexSearcher.<init> Opening
Searcher@ad245b[solrj_collection_shard1_replica2] main
[junit4] 2> 3542149 T10069 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 3542154 T10055
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 3542154 T10055
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 3542154 T10055 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica1' using configuration from collection
solrj_collection
[junit4] 2> 3542154 T10055 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3542156 T10055 oasc.SolrCore.<init>
[solrj_collection_shard2_replica1] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\data\
[junit4] 2> 3542156 T10055 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@19028
[junit4] 2> 3542157 T10055 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\data\
[junit4] 2> 3542157 T10055 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\data\index/
[junit4] 2> 3542157 T10055 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\data\index'
doesn't exist. Creating new index...
[junit4] 2> 3542158 T10055 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001\tempDir-005\solrj_collection_shard2_replica1\data\index
[junit4] 2> 3542159 T10055 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=38, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=1.4404296875,
floorSegmentMB=0.703125, forceMergeDeletesPctAllowed=22.45054876096744,
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.2249908444663974
[junit4] 2> 3542159 T10055 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-1d31f62)),segFN=segments_1,generation=1}
[junit4] 2> 3542159 T10055 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 3542163 T10055 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 3542163 T10055 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 3542164 T10055 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe"
[junit4] 2> 3542164 T10055 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 3542164 T10055 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"stored_sig"
[junit4] 2> 3542166 T10055 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3542166 T10055 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3542166 T10055 oasup.UpdateRequestProcessorChain.init
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 3542166 T10055 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3542168 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542168 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542168 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 3542169 T10055 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 3542169 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 3542169 T10055 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3542169 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 3542170 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 3542171 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3542172 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3542172 T10055 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3542174 T10055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542176 T10055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542178 T10055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542179 T10055 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3542183 T10055 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 3542183 T10055 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 3542184 T10055 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=48, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=96.
[...truncated too long message...]
unit4] 2> 5
/solr/collections/awholynewstresscollection_collection1_0/state.json
[junit4] 2> 5
/solr/collections/awholynewstresscollection_collection0_0/state.json
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 2
/solr/collections/awholynewcollection_2/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2
/solr/collections/awholynewstresscollection_collection1_0/leader_elect/shard3/election/92567905853440015-core_node10-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/live_nodes
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=testDistribSearch
-Dtests.seed=35C691C0BDEDB058 -Dtests.slow=true -Dtests.locale=ru_RU
-Dtests.timezone=America/Winnipeg -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 869s | CollectionsAPIDistributedZkTest.testDistribSearch
<<<
[junit4] > Throwable #1:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Error
CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core
[halfcollection_shard1_replica1] Caused by: Could not get shard id for core:
halfcollection_shard1_replica1
[junit4] > at
__randomizedtesting.SeedInfo.seed([35C691C0BDEDB058:B4201FD8CAB2D064]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:583)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.doTest(CollectionsAPIDistributedZkTest.java:205)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 4390109 T9981 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-35C691C0BDEDB058-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{other_tl1=FST41, _version_=FST41, multiDefault=PostingsFormat(name=Memory
doPackFST= true), a_t=PostingsFormat(name=Memory doPackFST= true),
intDefault=FST41, a_i1=PostingsFormat(name=Memory doPackFST= true),
id=PostingsFormat(name=Memory doPackFST= false),
text=PostingsFormat(name=MockRandom), range_facet_l=PostingsFormat(name=Memory
doPackFST= true), timestamp=PostingsFormat(name=Memory doPackFST= true)},
docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=DefaultSimilarity,
locale=ru_RU, timezone=America/Winnipeg
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_40-ea
(32-bit)/cpus=2,threads=1,free=75124624,total=436731904
[junit4] 2> NOTE: All tests run in this JVM: [ExternalCollectionsTest,
StatelessScriptUpdateProcessorFactoryTest, TestBinaryField,
MultiThreadedOCPTest, TestUtils, TestModifyConfFiles,
TestPartialUpdateDeduplication, TestRandomDVFaceting, TestStressUserVersions,
TestSolrXmlPersistence, SuggesterTest, PreAnalyzedUpdateProcessorTest,
CacheHeaderTest, TestSolrDeletionPolicy2, TestFieldSortValues,
HdfsBasicDistributedZkTest, SOLR749Test, TestIndexSearcher, TestStressRecovery,
SharedFSAutoReplicaFailoverTest, TestSweetSpotSimilarityFactory,
DeleteInactiveReplicaTest, MBeansHandlerTest, PreAnalyzedFieldTest,
DistributedFacetPivotLargeTest, FieldMutatingUpdateProcessorTest,
TestFieldCollectionResource, PolyFieldTest, TestNonNRTOpen,
TestBM25SimilarityFactory, RegexBoostProcessorTest, BadComponentTest,
TestCollapseQParserPlugin, AlternateDirectoryTest, StressHdfsTest,
FieldAnalysisRequestHandlerTest, ExternalFileFieldSortTest, UpdateParamsTest,
TestJmxMonitoredMap, BasicDistributedZk2Test, TestCollationFieldDocValues,
TestCloudManagedSchemaConcurrent, SolrIndexSplitterTest, TestSolrJ,
CoreAdminHandlerTest, MigrateRouteKeyTest, AddBlockUpdateTest,
DocExpirationUpdateProcessorFactoryTest, TestDynamicFieldResource,
IndexSchemaTest, CoreMergeIndexesAdminHandlerTest, SuggesterTSTTest,
TestSolr4Spatial, ShardRoutingCustomTest, DocumentBuilderTest, SolrCoreTest,
CustomCollectionTest, TestCloudInspectUtil, CloudExitableDirectoryReaderTest,
ResponseHeaderTest, TestSolrQueryParserResource, TestManagedSchema,
TestJmxIntegration, TermVectorComponentDistributedTest, BJQParserTest,
TestQueryUtils, PingRequestHandlerTest, TestManagedSynonymFilterFactory,
SchemaVersionSpecificBehaviorTest, LegacyHTMLStripCharFilterTest,
TestOmitPositions, ZkSolrClientTest, LeaderInitiatedRecoveryOnCommitTest,
TestUpdate, ZkNodePropsTest, BasicZkTest, TestManagedStopFilterFactory,
TestManagedSchemaDynamicFieldResource, IndexBasedSpellCheckerTest,
AnalysisErrorHandlingTest, BadIndexSchemaTest, TestAnalyzeInfixSuggestions,
HdfsDirectoryTest, TestPostingsSolrHighlighter, BasicDistributedZkTest,
BasicFunctionalityTest, MoreLikeThisHandlerTest, TestCharFilters,
TestCoreDiscovery, SortByFunctionTest, OpenCloseCoreStressTest,
ConnectionManagerTest, TestQuerySenderNoQuery, TestDistributedMissingSort,
ReplicationFactorTest, TestSolrXmlPersistor, DateFieldTest, ScriptEngineTest,
BinaryUpdateRequestHandlerTest, TestPivotHelperCode, TestRandomMergePolicy,
EchoParamsTest, TestManagedResourceStorage, TestLFUCache, TestStressLucene,
TestXIncludeConfig, XmlUpdateRequestHandlerTest, UnloadDistributedZkTest,
TestCodecSupport, TestDFRSimilarityFactory, MultiTermTest, ZkCLITest,
TestDistribDocBasedVersion, TestCollectionAPI, AsyncMigrateRouteKeyTest,
TestRequestStatusCollectionAPI, TestConfigSets, TestReload,
UniqFieldsUpdateProcessorFactoryTest, TestSchemaSimilarityResource,
QueryEqualityTest, NoCacheHeaderTest, TestFieldTypeCollectionResource,
CachingDirectoryFactoryTest, TestInitQParser, OutputWriterTest,
SolrPluginUtilsTest, UUIDUpdateProcessorFallbackTest,
TestFoldingMultitermQuery, DistributedQueryElevationComponentTest,
TestRangeQuery, TestOverriddenPrefixQueryForCustomFieldType, EnumFieldTest,
TestRecoveryHdfs, SolrCmdDistributorTest, DistributedFacetPivotSmallTest,
LeaderFailoverAfterPartitionTest, DisMaxRequestHandlerTest, TestConfig,
SampleTest, TestQueryTypes, TestIndexingPerformance, TestFiltering,
TestAddFieldRealTimeGet, SSLMigrationTest, TestFastWriter,
TestQuerySenderListener, TestHashPartitioner, TestDefaultSearchFieldResource,
TestSolrQueryParserDefaultOperatorResource, ChangedSchemaMergeTest,
TestExtendedDismaxParser, DistributedFacetPivotLongTailTest,
TestStressVersions, CoreContainerCoreInitFailuresTest, TestCloudSchemaless,
PathHierarchyTokenizerFactoryTest, TestSolrQueryParser,
QueryElevationComponentTest, TestBlendedInfixSuggestions, TestSolrIndexConfig,
SpellCheckComponentTest, TestComponentsName,
VMParamsZkACLAndCredentialsProvidersTest, TestDefaultSimilarityFactory,
TestRawResponseWriter, JSONWriterTest, TestNoOpRegenerator,
HdfsUnloadDistributedZkTest, SolrTestCaseJ4Test, CurrencyFieldOpenExchangeTest,
ShardRoutingTest, TestMultiCoreConfBootstrap, TestSort, MinimalSchemaTest,
ResourceLoaderTest, ModifyConfFileTest, SuggestComponentTest,
TestPerFieldSimilarity, TestIntervalFaceting, TestFunctionQuery,
FastVectorHighlighterTest, TestZkChroot, SolrInfoMBeanTest, SoftAutoCommitTest,
TestWriterPerf, SolrRequestParserTest, RecoveryZkTest, TestTolerantSearch,
TestBadConfig, OverseerTest, InfoHandlerTest, SolrCoreCheckLockOnStartupTest,
DOMUtilTest, ZkControllerTest, TestImplicitCoreProperties, TestNRTOpen,
HdfsBasicDistributedZk2Test, TestSolrDeletionPolicy1, TestLRUCache,
TestShortCircuitedRequests, AssignTest, TestManagedSchemaFieldTypeResource,
HdfsRecoveryZkTest, TestCopyFieldCollectionResource, ChaosMonkeySafeLeaderTest,
DefaultValueUpdateProcessorTest, OpenExchangeRatesOrgProviderTest,
ChaosMonkeyNothingIsSafeTest, TestDistributedSearch,
StandardRequestHandlerTest, TestPhraseSuggestions,
CollectionsAPIDistributedZkTest]
[junit4] Completed in 869.15s, 1 test, 1 error <<< FAILURES!
[...truncated 663 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:524: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:472: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1359:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:961:
There were test failures: 436 suites, 1784 tests, 1 error, 53 ignored (31
assumptions)
Total time: 158 minutes 1 second
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b04 -server
-XX:+UseParallelGC
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]
