Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4229/
Java: 64bit/jdk1.8.0_40-ea-b04 -XX:-UseCompressedOops -XX:+UseG1GC
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([FE701619B062323B:7F969801C73D5207]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
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.GeneratedMethodAccessor41.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 11396 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\init-core-data-001
[junit4] 2> 2530549 T7016 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 2530549 T7016
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 2530554 T7016 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 2530555 T7016 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2530556 T7017 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 2530671 T7016 oasc.ZkTestServer.run start zk server on
port:49743
[junit4] 2> 2530672 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2530675 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2530683 T7023 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5a624b94
name:ZooKeeperConnection Watcher:127.0.0.1:49743 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2530684 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2530684 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2530684 T7016 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 2530700 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2530701 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2530706 T7025 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5d2b7482
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2530706 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2530707 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2530707 T7016 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 2530715 T7016 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 2530720 T7016 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 2530724 T7016 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 2530727 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2530727 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 2530734 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 2530734 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 2530740 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2530740 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2530745 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2530745 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 2530750 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2530750 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 2530754 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2530754 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 2530759 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2530759 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 2530764 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2530764 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 2530769 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2530769 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2530774 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2530774 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 2530779 T7016 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2530779 T7016 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> Using new style solr.xml
[junit4] 2> 2532681 T7016 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2532700 T7016 oejs.AbstractConnector.doStart Started
[email protected]:49750
[junit4] 2> 2532701 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2532701 T7016 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2532701 T7016 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002
[junit4] 2> 2532703 T7016 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002\'
[junit4] 2> 2532751 T7016 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002\solr.xml
[junit4] 2> 2532766 T7016 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002
[junit4] 2> 2532767 T7016 oasc.CoreContainer.<init> New CoreContainer
640858724
[junit4] 2> 2532767 T7016 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002\]
[junit4] 2> 2532768 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2532768 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2532768 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2532769 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2532769 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2532769 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2532769 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2532770 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2532771 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2532771 T7016 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2532771 T7016 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2532772 T7016 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2532772 T7016 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2532772 T7016 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49743/solr
[junit4] 2> 2532772 T7016 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2532773 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2532777 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2532779 T7036 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4ea3e681
name:ZooKeeperConnection Watcher:127.0.0.1:49743 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2532779 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2532779 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2532783 T7018 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x1489def844d0002, 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> 2532784 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2532790 T7038 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4fac7ad4
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2532790 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2532792 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 2532798 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 2532803 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 2532808 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 2532812 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 2532818 T7016 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 2532820 T7016 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49750_
[junit4] 2> 2532821 T7016 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49750_
[junit4] 2> 2532826 T7016 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 2532830 T7016 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 2532833 T7016 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2532837 T7016 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:49750_
[junit4] 2> 2532837 T7016 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 2532840 T7016 oasc.Overseer.start Overseer
(id=92497444403478531-127.0.0.1:49750_-n_0000000000) starting
[junit4] 2> 2532845 T7016 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 2532860 T7016 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2532866 T7040 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 2532868 T7039 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 2532869 T7016 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 2532878 T7016 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 2532882 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2532892 T7016 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002
[junit4] 2> 2534207 T7016 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-002\conf\
[junit4] 2> 2534432 T7016 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2534433 T7016 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2534433 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2534435 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2534437 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2534439 T7044 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@13211d13
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2534439 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2534439 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2534441 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2534447 T7016 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 2534447 T7016 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 2534447 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2534450 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2534451 T7046 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@20f37489
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2534451 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2534451 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2534455 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2534458 T7018 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x1489def844d0005, 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> 2534463 T7039
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
collection1
[junit4] 2> 2534463 T7039
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
collection1 with shards [shard1, shard2]
[junit4] 2> 2534463 T7039
oasc.Overseer$ClusterStateUpdater.createCollection state version collection1 2
[junit4] 2> 2534469 T7039 oasc.Overseer$ClusterStateUpdater.updateZkStates
going to create_collection /collections/collection1/state.json
[junit4] 2> 2534472 T7047 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> 2534475 T7048 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> 2536303 T7016 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 2536303 T7016 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2536309 T7016 oejs.AbstractConnector.doStart Started
[email protected]:49765
[junit4] 2> 2536311 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2536311 T7016 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2536312 T7016 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003
[junit4] 2> 2536312 T7016 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\'
[junit4] 2> 2536353 T7016 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solr.xml
[junit4] 2> 2536368 T7016 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003
[junit4] 2> 2536369 T7016 oasc.CoreContainer.<init> New CoreContainer
706244309
[junit4] 2> 2536369 T7016 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\]
[junit4] 2> 2536370 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2536370 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2536371 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2536371 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2536371 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2536372 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2536372 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2536372 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2536373 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2536373 T7016 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2536374 T7016 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2536374 T7016 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2536374 T7016 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2536376 T7016 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49743/solr
[junit4] 2> 2536376 T7016 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2536376 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2536378 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2536381 T7059 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5a705ec6
name:ZooKeeperConnection Watcher:127.0.0.1:49743 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2536382 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2536383 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2536388 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2536391 T7061 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@70cedc8a
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2536391 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2536406 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2537557 T7016 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49765_
[junit4] 2> 2537560 T7016 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49765_
[junit4] 2> 2537572 T7016 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2537577 T7016 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003
[junit4] 2> 2538849 T7016 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\conf\
[junit4] 2> 2539080 T7016 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2539082 T7016 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2539082 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2541386 T7016 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 2541387 T7016 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2541392 T7016 oejs.AbstractConnector.doStart Started
[email protected]:49774
[junit4] 2> 2541393 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2541394 T7016 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2541394 T7016 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004
[junit4] 2> 2541394 T7016 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\'
[junit4] 2> 2541435 T7016 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solr.xml
[junit4] 2> 2541452 T7016 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004
[junit4] 2> 2541452 T7016 oasc.CoreContainer.<init> New CoreContainer
975506907
[junit4] 2> 2541453 T7016 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\]
[junit4] 2> 2541453 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2541454 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2541454 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2541454 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2541455 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2541455 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2541455 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2541457 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2541457 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2541457 T7016 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2541458 T7016 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2541458 T7016 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2541459 T7016 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2541459 T7016 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49743/solr
[junit4] 2> 2541459 T7016 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2541459 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2541463 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2541465 T7074 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@43898131
name:ZooKeeperConnection Watcher:127.0.0.1:49743 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2541466 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2541468 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2541473 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2541474 T7076 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@1edad933
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2541475 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2541495 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2542762 T7016 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49774_
[junit4] 2> 2542766 T7016 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49774_
[junit4] 2> 2542783 T7016 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2542794 T7016 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004
[junit4] 2> 2544302 T7016 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\conf\
[junit4] 2> 2544598 T7016 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2544600 T7016 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2544602 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2546802 T7016 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 2546803 T7016 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2546808 T7016 oejs.AbstractConnector.doStart Started
[email protected]:49783
[junit4] 2> 2546808 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2546808 T7016 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2546808 T7016 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005
[junit4] 2> 2546808 T7016 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\'
[junit4] 2> 2546858 T7016 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solr.xml
[junit4] 2> 2546919 T7016 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005
[junit4] 2> 2546920 T7016 oasc.CoreContainer.<init> New CoreContainer
1466108248
[junit4] 2> 2546920 T7016 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\]
[junit4] 2> 2546922 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2546923 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2546923 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2546923 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2546923 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2546923 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2546927 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2546927 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2546927 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2546927 T7016 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2546927 T7016 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2546927 T7016 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2546927 T7016 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2546927 T7016 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49743/solr
[junit4] 2> 2546927 T7016 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2546927 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2546934 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2546936 T7089 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@685c6b51
name:ZooKeeperConnection Watcher:127.0.0.1:49743 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2546938 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2546938 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2546940 T7018 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x1489def844d000a, 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> 2546941 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2546944 T7091 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@771a9664
name:ZooKeeperConnection Watcher:127.0.0.1:49743/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2546944 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2546956 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2548222 T7016 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49783_
[junit4] 2> 2548226 T7016 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49783_
[junit4] 2> 2548248 T7016 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2548258 T7016 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005
[junit4] 2> 2549110 T7016 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\conf\
[junit4] 2> 2549241 T7016 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2549244 T7016 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2549244 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2551536 T7016 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 2551537 T7016 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2551542 T7016 oejs.AbstractConnector.doStart Started
[email protected]:49792
[junit4] 2> 2551544 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()
[junit4] 2> 2551544 T7016 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2551545 T7016 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006
[junit4] 2> 2551545 T7016 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006\'
[junit4] 2> 2551585 T7016 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006\solr.xml
[junit4] 2> 2551601 T7016 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006
[junit4] 2> 2551602 T7016 oasc.CoreContainer.<init> New CoreContainer
420772310
[junit4] 2> 2551602 T7016 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006\]
[junit4] 2> 2551604 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2551604 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2551604 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2551605 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2551606 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2551606 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2551606 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2551607 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2551607 T7016 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2551608 T7016 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2551608 T7016 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2551608 T7016 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2551608 T7016 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2551610 T7016 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:49743/solr
[junit4] 2> 2551610 T7016 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2551611 T7016
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2551613 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2551616 T7104 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2d2bae3 name:ZooKeeperConnection
Watcher:127.0.0.1:49743 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2551617 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2551617 T7016 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2551623 T7016 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2551626 T7106 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3bc1b8d name:ZooKeeperConnection
Watcher:127.0.0.1:49743/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2551627 T7016 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2551644 T7016
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2553025 T7016 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49792_
[junit4] 2> 2553029 T7016 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:49792_
[junit4] 2> 2553057 T7016 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2553061 T7016 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006
[junit4] 2> 2554633 T7016 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006\conf\
[junit4] 2> 2554909 T7016 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2554913 T7016 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2554913 T7016 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2554923 T7053 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> 2554925 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/collection-queue-work state:
SyncConnected type NodeChildrenChanged
[junit4] 2> 2554928 T7040 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> 2554931 T7109 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> 2554939 T7109 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/solrj_collection
[junit4] 2> 2554942 T7109 oascc.SolrZkClient.makePath makePath:
/collections/solrj_collection
[junit4] 2> 2554951 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2554959 T7039
oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection:
solrj_collection
[junit4] 2> 2554960 T7039
oasc.Overseer$ClusterStateUpdater.createCollection Create collection
solrj_collection with shards [shard1, shard2]
[junit4] 2> 2554960 T7039
oasc.Overseer$ClusterStateUpdater.createCollection state version
solrj_collection 1
[junit4] 2> 2554966 T7062 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> 2554967 T7092 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> 2554967 T7077 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> 2554969 T7048 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> 2554969 T7047 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> 2554969 T7107 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> 2555090 T7109
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection solrj_collection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 2555090 T7109
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica1 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:49765_
[junit4] 2> 2555092 T7109
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard1_replica2 as part of slice shard1 of collection
solrj_collection on 127.0.0.1:49774_
[junit4] 2> 2555095 T7109
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica1 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:49792_
[junit4] 2> 2555098 T7054 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> 2555100 T7069 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> 2555102 T7109
oasc.OverseerCollectionProcessor.createCollection Creating shard
solrj_collection_shard2_replica2 as part of slice shard2 of collection
solrj_collection on 127.0.0.1:49783_
[junit4] 2> 2555106 T7054 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica1 state=down collection=solrj_collection
[junit4] 2> 2555106 T7069 oasc.ZkController.publish publishing
core=solrj_collection_shard1_replica2 state=down collection=solrj_collection
[junit4] 2> 2555107 T7097 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> 2555113 T7085 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> 2555114 T7069 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2555114 T7054 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2555115 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2555117 T7097 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica1 state=down collection=solrj_collection
[junit4] 2> 2555119 T7097 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2555121 T7085 oasc.ZkController.publish publishing
core=solrj_collection_shard2_replica2 state=down collection=solrj_collection
[junit4] 2> 2555122 T7085 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2555129 T7039 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:49765";,
[junit4] 2> "node_name":"127.0.0.1:49765_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 2555135 T7039 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:49774";,
[junit4] 2> "node_name":"127.0.0.1:49774_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 2555142 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2555144 T7039 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:49792";,
[junit4] 2> "node_name":"127.0.0.1:49792_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 2555149 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2555152 T7039 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:49783";,
[junit4] 2> "node_name":"127.0.0.1:49783_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"solrj_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 2555158 T7047 oasc.DistributedQueue$LatchChildWatcher.process
LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type
NodeChildrenChanged
[junit4] 2> 2555161 T7048 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> 2555161 T7077 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> 2555161 T7062 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> 2555162 T7107 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> 2555162 T7092 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> 2555162 T7047 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> 2556494 T7069 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica2
[junit4] 2> 2556494 T7054 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard1_replica1
[junit4] 2> 2556495 T7054 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2556494 T7069 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2556496 T7069 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2556496 T7069 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2556496 T7054 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2556498 T7054 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2556498 T7097 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica1
[junit4] 2> 2556499 T7097 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2556500 T7069 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2556502 T7069 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\'
[junit4] 2> 2556502 T7085 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for solrj_collection_shard2_replica2
[junit4] 2> 2556502 T7085 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:solrj_collection
[junit4] 2> 2556502 T7097 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2556503 T7097 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2556504 T7054 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2556504 T7054 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\'
[junit4] 2> 2556509 T7085 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2556509 T7085 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/solrj_collection
[junit4] 2> 2556513 T7097 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2556513 T7097 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-006\solrj_collection_shard2_replica1\'
[junit4] 2> 2556533 T7085 oascc.ZkStateReader.readConfigName
path=/collections/solrj_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2556533 T7085 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\'
[junit4] 2> 2556607 T7085 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2556616 T7069 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2556622 T7085 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2556607 T7054 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2556632 T7069 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2556669 T7054 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2556677 T7085 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2556678 T7097 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 5.0.0
[junit4] 2> 2556685 T7085 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica2] Schema name=test
[junit4] 2> 2556694 T7054 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2556704 T7054 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica1] Schema name=test
[junit4] 2> 2556783 T7097 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2556872 T7085 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2556881 T7085 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2556883 T7054 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2556883 T7085 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2556889 T7054 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2556891 T7054 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2556893 T7069 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2556893 T7097 oass.IndexSchema.readSchema Reading Solr Schema
from schema.xml
[junit4] 2> 2556902 T7069 oass.IndexSchema.readSchema
[solrj_collection_shard1_replica2] Schema name=test
[junit4] 2> 2556949 T7097 oass.IndexSchema.readSchema
[solrj_collection_shard2_replica1] Schema name=test
[junit4] 2> 2557093 T7069 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2557098 T7069 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2557099 T7069 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2557137 T7085 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557138 T7097 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2557145 T7085 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557145 T7097 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2557149 T7097 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2557149 T7054 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557155 T7085 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557156 T7069 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557159 T7054 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557161 T7085
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557161 T7069 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557163 T7085
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557164 T7085 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557167 T7054 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557169 T7085
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557171 T7085
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557171 T7085 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard2_replica2' using configuration from collection
solrj_collection
[junit4] 2> 2557171 T7085 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2557171 T7069 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557172 T7085 oasc.SolrCore.<init>
[solrj_collection_shard2_replica2] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\data\
[junit4] 2> 2557172 T7085 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@39109279
[junit4] 2> 2557173 T7085 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\data\
[junit4] 2> 2557175 T7054
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557175 T7054
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557175 T7085 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\data\index/
[junit4] 2> 2557175 T7069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557176 T7069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557176 T7069 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557179 T7085 oasc.SolrCore.initIndex WARN
[solrj_collection_shard2_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2557175 T7054 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557180 T7085 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-005\solrj_collection_shard2_replica2\data\index
[junit4] 2> 2557180 T7085 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=18, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=97.359375,
floorSegmentMB=1.40625, forceMergeDeletesPctAllowed=26.999046424232734,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5245400082011223
[junit4] 2> 2557182 T7069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557183 T7069
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557183 T7069 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica2' using configuration from collection
solrj_collection
[junit4] 2> 2557183 T7069 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2557184 T7069 oasc.SolrCore.<init>
[solrj_collection_shard1_replica2] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\data\
[junit4] 2> 2557184 T7069 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@39109279
[junit4] 2> 2557184 T7054
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2557186 T7054
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2557186 T7054 oasc.CoreContainer.create Creating SolrCore
'solrj_collection_shard1_replica1' using configuration from collection
solrj_collection
[junit4] 2> 2557186 T7054 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2557184 T7069 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\data\
[junit4] 2> 2557187 T7054 oasc.SolrCore.<init>
[solrj_collection_shard1_replica1] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\data\
[junit4] 2> 2557188 T7054 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@39109279
[junit4] 2> 2557188 T7085 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-39cd119)),segFN=segments_1,generation=1}
[junit4] 2> 2557190 T7085 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2557188 T7069 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\data\index/
[junit4] 2> 2557190 T7069 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2557191 T7069 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-004\solrj_collection_shard1_replica2\data\index
[junit4] 2> 2557192 T7069 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=18, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=97.359375,
floorSegmentMB=1.40625, forceMergeDeletesPctAllowed=26.999046424232734,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5245400082011223
[junit4] 2> 2557192 T7069 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-1e3c797c)),segFN=segments_1,generation=1}
[junit4] 2> 2557192 T7069 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2557194 T7085 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2557195 T7085 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2557195 T7085 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2557195 T7085 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557196 T7085 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557196 T7085 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2557196 T7069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2557198 T7069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2557188 T7054 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\data\
[junit4] 2> 2557200 T7069 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2557200 T7054 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\data\index/
[junit4] 2> 2557202 T7054 oasc.SolrCore.initIndex WARN
[solrj_collection_shard1_replica1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2557196 T7085 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2557203 T7054 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001\tempDir-003\solrj_collection_shard1_replica1\data\index
[junit4] 2> 2557203 T7054 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=18, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=97.359375,
floorSegmentMB=1.40625, forceMergeDeletesPctAllowed=26.999046424232734,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5245400082011223
[junit4] 2> 2557202 T7069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557204 T7054 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory(id=lucene-1e1217c8)),segFN=segments_1,generation=1}
[junit4] 2> 2557206 T7054 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2557203 T7085 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2557207 T7085 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2557207 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557208 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557208 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557210 T7085 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2557210 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 2557210 T7085 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 2557211 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 2557204 T7069 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557213 T7069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2557211 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 2557210 T7054 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2557214 T7054 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2557214 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 2557213 T7069 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2557217 T7069 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2557213 T7097 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557217 T7069 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2557215 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2557218 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557218 T7085 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2557214 T7054 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2557221 T7054 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557222 T7054 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2557222 T7054 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2557222 T7054 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2557223 T7054 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2557223 T7054 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2557223 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557225 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557225 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557225 T7054 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2557226 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 2557226 T7054 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 2557226 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 2557227 T7085 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557218 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557229 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2557230 T7069 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2557227 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 2557231 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 2557233 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2557233 T7054 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2557234 T7097 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2557231 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /get: solr.RealTimeGetHandler
[junit4] 2> 2557235 T7069 oasc.RequestHandlers.initHandlersFromConfig
adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 2557235 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /replication: solr.ReplicationHandler
[junit4] 2> 2557237 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /update: solr.UpdateRequestHandler
[junit4] 2> 2557230 T7085 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557239 T7085 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557239 T7097 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2557237 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 2557235 T7054 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557242 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2557243 T7069 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2557243 T7054 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557246 T7069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557246 T7054 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557248 T7069 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557249 T7054 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2557250 T7069 oashl.XMLLoader.init xsltCacheLifetime
[...truncated too long message...]
ient.java:347)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:344)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:344)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:383)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:126)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$1.run(Overseer.java:333)
[junit4] 2>
[junit4] 2> 3292433 T7647 oascc.ZkStateReader$2.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 3292433 T7657 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 3292448 T7016 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 3296952 T7016 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 3296959 T7016 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:49743 49743
[junit4] 2> 3299092 T7251 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:49743 49743
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=testDistribSearch
-Dtests.seed=FE701619B062323B -Dtests.slow=true -Dtests.locale=ar_LY
-Dtests.timezone=America/Godthab -Dtests.file.encoding=UTF-8
[junit4] ERROR 769s | 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([FE701619B062323B:7F969801C73D5207]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:550)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
[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> 3299126 T7016 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest-FE701619B062323B-001
[junit4] 2> NOTE: test params are: codec=Lucene410:
{other_tl1=PostingsFormat(name=Direct), _version_=PostingsFormat(name=Direct),
multiDefault=PostingsFormat(name=Lucene41WithOrds),
a_t=PostingsFormat(name=Lucene41WithOrds),
intDefault=PostingsFormat(name=Direct),
a_i1=PostingsFormat(name=Lucene41WithOrds), id=FST41,
text=PostingsFormat(name=Memory doPackFST= false),
range_facet_l=PostingsFormat(name=Lucene41WithOrds),
timestamp=PostingsFormat(name=Lucene41WithOrds)},
docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=DefaultSimilarity,
locale=ar_LY, timezone=America/Godthab
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40-ea
(64-bit)/cpus=2,threads=1,free=271301656,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestAddFieldRealTimeGet,
TestCSVLoader, VMParamsZkACLAndCredentialsProvidersTest,
DistributedQueryComponentOptimizationTest, TestDefaultSearchFieldResource,
TestInitQParser, ZkCLITest, ConnectionManagerTest, TestLeaderElectionZkExpiry,
HighlighterMaxOffsetTest, TestPhraseSuggestions, HdfsDirectoryTest,
QueryEqualityTest, DateMathParserTest, TestPHPSerializedResponseWriter,
TestOverriddenPrefixQueryForCustomFieldType, FileUtilsTest, TestXIncludeConfig,
TestHashPartitioner, DocExpirationUpdateProcessorFactoryTest,
TestSuggestSpellingConverter, TriLevelCompositeIdRoutingTest,
HdfsWriteToMultipleCollectionsTest, TestReplicationHandler,
SolrPluginUtilsTest, InfoHandlerTest, TestManagedSynonymFilterFactory,
CacheHeaderTest, SearchHandlerTest, TestFieldSortValues, TestCollectionAPI,
TestSolrDeletionPolicy2, ReturnFieldsTest, ReplicationFactorTest,
RollingRestartTest, MultiTermTest, TestRequestStatusCollectionAPI,
BadComponentTest, TestAnalyzedSuggestions, FullSolrCloudDistribCmdsTest,
SpellCheckCollatorTest, SharedFSAutoReplicaFailoverTest, HdfsSyncSliceTest,
BasicDistributedZk2Test, ZkNodePropsTest, SystemInfoHandlerTest, RankQueryTest,
AddSchemaFieldsUpdateProcessorFactoryTest, ChangedSchemaMergeTest,
SpellPossibilityIteratorTest, TestQueryTypes, TermVectorComponentTest,
TestLMDirichletSimilarityFactory, HdfsBasicDistributedZk2Test,
WordBreakSolrSpellCheckerTest, BadCopyFieldTest, UnloadDistributedZkTest,
StatsComponentTest, TestTolerantSearch, TestSortingResponseWriter, TestConfig,
SoftAutoCommitTest, TestAtomicUpdateErrorCases, TestBlendedInfixSuggestions,
TermsComponentTest, TestSolrCoreProperties, ShardRoutingCustomTest,
URLClassifyProcessorTest, MBeansHandlerTest, TimeZoneUtilsTest,
TestCopyFieldCollectionResource, ResourceLoaderTest, TestQuerySenderListener,
EnumFieldTest, SolrIndexSplitterTest, TestReversedWildcardFilterFactory,
ZkSolrClientTest, TestSolrQueryParser, TestMaxScoreQueryParser,
CachingDirectoryFactoryTest, FastVectorHighlighterTest, AutoCommitTest,
BasicZkTest, TestCodecSupport, RAMDirectoryFactoryTest,
IndexSchemaRuntimeFieldTest, TestSystemIdResolver,
TestManagedSchemaDynamicFieldResource, TestSchemaVersionResource,
TestDistributedGrouping, CircularListTest, TestOrdValues,
DefaultValueUpdateProcessorTest, CollectionsAPIAsyncDistributedZkTest,
RequiredFieldsTest, TestSolr4Spatial, PluginInfoTest,
TestElisionMultitermQuery, QueryResultKeyTest, TestRandomMergePolicy,
TestShardHandlerFactory, SampleTest, TestLazyCores, FileBasedSpellCheckerTest,
TestMiniSolrCloudCluster, TestWordDelimiterFilterFactory, SolrXmlInZkTest,
AssignTest, ModifyConfFileTest, TestRandomDVFaceting, DocValuesMultiTest,
HdfsRecoveryZkTest, TestStressReorder, CoreAdminCreateDiscoverTest,
TestSweetSpotSimilarityFactory, TestReplicationHandlerBackup, ScriptEngineTest,
TestSchemaNameResource, UniqFieldsUpdateProcessorFactoryTest,
ResponseHeaderTest, TestSolrDeletionPolicy1, LeaderElectionTest,
RemoteQueryErrorTest, HdfsLockFactoryTest, SolrRequestParserTest,
LegacyHTMLStripCharFilterTest, TestSolr4Spatial2, TestUniqueKeyFieldResource,
SpellCheckComponentTest, SyncSliceTest, LukeRequestHandlerTest,
DistanceFunctionTest, DOMUtilTest, TestCloudManagedSchema,
SpellingQueryConverterTest, DistributedQueryComponentCustomSortTest,
SynonymTokenizerTest, HighlighterConfigTest, IndexSchemaTest,
TestArbitraryIndexDir, TestBM25SimilarityFactory, SOLR749Test,
TestExtendedDismaxParser, DocumentBuilderTest, PeerSyncTest,
DisMaxRequestHandlerTest, BadIndexSchemaTest, DateRangeFieldTest,
TestFastLRUCache, TestFieldTypeCollectionResource,
TestManagedSchemaFieldResource, HdfsUnloadDistributedZkTest, SuggesterFSTTest,
TestPostingsSolrHighlighter, TestStressRecovery, RequestHandlersTest,
OverseerCollectionProcessorTest, TestCollationFieldDocValues, TestRTGBase,
DistributedFacetPivotLargeTest, ClusterStateUpdateTest, TestSearcherReuse,
TestConfigSets, TestFoldingMultitermQuery, TestManagedResource,
TestNonDefinedSimilarityFactory, OverriddenZkACLAndCredentialsProvidersTest,
TestStandardQParsers, RecoveryZkTest, TestFastOutputStream, JSONWriterTest,
SimpleFacetsTest, SharedFSAutoReplicaFailoverUtilsTest, TestFunctionQuery,
CustomCollectionTest, OverseerTest, SuggestComponentTest, TestPivotHelperCode,
TestDocBasedVersionConstraints, DistributedIntervalFacetingTest,
SolrIndexConfigTest, TestDefaultSimilarityFactory, SolrCmdDistributorTest,
TestNonNRTOpen, TestUpdate, TestFieldCollectionResource,
CurrencyFieldXmlFileTest, DistributedQueryElevationComponentTest,
TestBadConfig, TestInitParams, TestFreeTextSuggestions, AlternateDirectoryTest,
TestSolrJ, CollectionsAPIDistributedZkTest]
[junit4] Completed in 768.62s, 1 test, 1 error <<< FAILURES!
[...truncated 742 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:491: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:471: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:60: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:189: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:496:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1359:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:962:
There were test failures: 429 suites, 1772 tests, 1 error, 54 ignored (32
assumptions)
Total time: 166 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b04
-XX:-UseCompressedOops -XX:+UseG1GC
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]
