Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4526/
Java: 64bit/jdk1.8.0_40-ea-b09 -XX:+UseCompressedOops -XX:+UseG1GC (asserts:
false)
1 tests failed.
FAILED: org.apache.solr.cloud.DeleteReplicaTest.testDistribSearch
Error Message:
Should have had a good message here
Stack Trace:
java.lang.AssertionError: Should have had a good message here
at
__randomizedtesting.SeedInfo.seed([DE0AD8B60000011D:5FEC56AE775F6121]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:138)
at
org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:89)
at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
at sun.reflect.GeneratedMethodAccessor50.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9447 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\init-core-data-001
[junit4] 2> 2150270 T9646 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 2150270 T9646
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 2150274 T9646 oas.SolrTestCaseJ4.setUp ###Starting
testDistribSearch
[junit4] 2> 2150274 T9646 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2150276 T9647 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 2150381 T9646 oasc.ZkTestServer.run start zk server on
port:54698
[junit4] 2> 2150381 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2150383 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2150389 T9654 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@37fea3c2
name:ZooKeeperConnection Watcher:127.0.0.1:54698 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2150389 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2150390 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2150390 T9646 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 2150394 T9648 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14aa583333c0000, 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> 2150394 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2150396 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2150399 T9657 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@76675ce5
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2150399 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2150399 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2150399 T9646 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 2150403 T9646 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 2150407 T9646 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 2150409 T9646 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 2150413 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2150413 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 2150418 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 2150419 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 2150423 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2150424 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2150426 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2150426 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 2150428 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2150429 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 2150432 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2150433 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 2150437 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2150438 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 2150441 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2150442 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 2150445 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2150445 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2150449 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2150449 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 2150453 T9646 oasc.AbstractZkTestCase.putConfig put
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2150453 T9646 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 2150457 T9648 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14aa583333c0001, 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> 2151918 T9646 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2151955 T9646 oejs.AbstractConnector.doStart Started
[email protected]:54705
[junit4] 2> 2151956 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 2151956 T9646 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2151956 T9646 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002
[junit4] 2> 2151956 T9646 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\'
[junit4] 2> 2151984 T9646 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\solr.xml
[junit4] 2> 2151991 T9646 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002
[junit4] 2> 2151994 T9646 oasc.CoreContainer.<init> New CoreContainer
2066974842
[junit4] 2> 2151994 T9646 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\]
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2151996 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2151996 T9646 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2151998 T9646 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2151998 T9646 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2151998 T9646 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2151998 T9646 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:54698/solr
[junit4] 2> 2151998 T9646 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2151998 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2152001 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2152004 T9669 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@6d2cefca
name:ZooKeeperConnection Watcher:127.0.0.1:54698 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2152004 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2152004 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2152006 T9648 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14aa583333c0002, 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> 2152007 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2152009 T9672 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3467c1f7
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2152009 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2152011 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/queue
[junit4] 2> 2152016 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/collection-queue-work
[junit4] 2> 2152020 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-running
[junit4] 2> 2152024 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-completed
[junit4] 2> 2152027 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/collection-map-failure
[junit4] 2> 2152032 T9646 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 2152034 T9646 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54705_
[junit4] 2> 2152035 T9646 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:54705_
[junit4] 2> 2152039 T9646 oascc.SolrZkClient.makePath makePath:
/overseer_elect
[junit4] 2> 2152043 T9646 oascc.SolrZkClient.makePath makePath:
/overseer_elect/election
[junit4] 2> 2152046 T9646 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2152048 T9646 oasc.OverseerElectionContext.runLeaderProcess I
am going to be the leader 127.0.0.1:54705_
[junit4] 2> 2152049 T9646 oascc.SolrZkClient.makePath makePath:
/overseer_elect/leader
[junit4] 2> 2152051 T9646 oasc.Overseer.start Overseer
(id=93068725233385475-127.0.0.1:54705_-n_0000000000) starting
[junit4] 2> 2152055 T9646 oascc.SolrZkClient.makePath makePath:
/overseer/queue-work
[junit4] 2> 2152066 T9646 oasc.OverseerAutoReplicaFailoverThread.<init>
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2152069 T9674 oasc.OverseerCollectionProcessor.run Process
current queue of collection creations
[junit4] 2> 2152069 T9646 oascc.SolrZkClient.makePath makePath:
/clusterstate.json
[junit4] 2> 2152073 T9646 oascc.SolrZkClient.makePath makePath:
/aliases.json
[junit4] 2> 2152075 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2152081 T9646 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002
[junit4] 2> 2152087 T9673 oasc.Overseer$ClusterStateUpdater.run Starting
to work on the main queue
[junit4] 2> 2152702 T9646 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\conf\
[junit4] 2> 2152810 T9646 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2152813 T9646 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2152813 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2152814 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2152815 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2152817 T9679 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@73afa65d
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2152818 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2152818 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2152819 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2152825 T9646 oasc.ChaosMonkey.monkeyLog monkey: init - expire
sessions:false cause connection loss:false
[junit4] 2> 2152825 T9646 oasc.AbstractFullDistribZkTestBase.createJettys
Creating collection1 with stateFormat=2
[junit4] 2> 2152825 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2152826 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2152828 T9682 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@20aab687
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2152829 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2152829 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2152831 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2152832 T9648 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14aa583333c0005, 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> 2152838 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":2} current state version: 0
[junit4] 2> 2152838 T9673 oasco.ClusterStateMutator.createCollection
building a new cName: collection1
[junit4] 2> 2152840 T9673 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/collection1/state.json
[junit4] 2> 2152842 T9672 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> 2152842 T9679 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> 2154269 T9646 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1
[junit4] 2> 2154269 T9646 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2154272 T9646 oejs.AbstractConnector.doStart Started
[email protected]:54720
[junit4] 2> 2154273 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 2154273 T9646 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2154273 T9646 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003
[junit4] 2> 2154273 T9646 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003\'
[junit4] 2> 2154303 T9646 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003\solr.xml
[junit4] 2> 2154310 T9646 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003
[junit4] 2> 2154311 T9646 oasc.CoreContainer.<init> New CoreContainer
1049756007
[junit4] 2> 2154311 T9646 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003\]
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2154314 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2154317 T9646 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2154317 T9646 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2154317 T9646 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2154317 T9646 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2154317 T9646 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:54698/solr
[junit4] 2> 2154317 T9646 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2154317 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2154320 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2154349 T9694 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@bf7e666 name:ZooKeeperConnection
Watcher:127.0.0.1:54698 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2154351 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2154351 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2154355 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2154357 T9697 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@76ef57aa
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2154357 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2154368 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2155425 T9646 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54720_
[junit4] 2> 2155428 T9646 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:54720_
[junit4] 2> 2155446 T9646 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2155453 T9646 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003
[junit4] 2> 2156086 T9646 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-003\conf\
[junit4] 2> 2156196 T9646 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2156197 T9646 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2156197 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2157713 T9646 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2
[junit4] 2> 2157714 T9646 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2157717 T9646 oejs.AbstractConnector.doStart Started
[email protected]:54729
[junit4] 2> 2157719 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 2157719 T9646 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2157719 T9646 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004
[junit4] 2> 2157719 T9646 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004\'
[junit4] 2> 2157750 T9646 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004\solr.xml
[junit4] 2> 2157759 T9646 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004
[junit4] 2> 2157759 T9646 oasc.CoreContainer.<init> New CoreContainer
657157493
[junit4] 2> 2157759 T9646 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004\]
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2157760 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2157760 T9646 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2157760 T9646 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2157763 T9646 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2157763 T9646 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2157763 T9646 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:54698/solr
[junit4] 2> 2157763 T9646 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2157763 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2157766 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2157768 T9710 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@9014b6a name:ZooKeeperConnection
Watcher:127.0.0.1:54698 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2157769 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2157769 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2157773 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2157775 T9713 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@40b2d598
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2157775 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2157787 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2158843 T9646 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54729_
[junit4] 2> 2158844 T9646 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:54729_
[junit4] 2> 2158851 T9646 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2158856 T9646 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004
[junit4] 2> 2159956 T9646 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004\conf\
[junit4] 2> 2160147 T9646 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2160150 T9646 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2160150 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2161936 T9646 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 3
[junit4] 2> 2161937 T9646 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2161941 T9646 oejs.AbstractConnector.doStart Started
[email protected]:54738
[junit4] 2> 2161943 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 2161943 T9646 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2161943 T9646 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005
[junit4] 2> 2161943 T9646 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005\'
[junit4] 2> 2161980 T9646 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005\solr.xml
[junit4] 2> 2161991 T9646 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005
[junit4] 2> 2161991 T9646 oasc.CoreContainer.<init> New CoreContainer
1758700068
[junit4] 2> 2161991 T9646 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005\]
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2161995 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2161995 T9646 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2161995 T9646 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2161995 T9646 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2161995 T9646 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2161995 T9646 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:54698/solr
[junit4] 2> 2161995 T9646 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2161995 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2162000 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2162002 T9726 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@7c817c35
name:ZooKeeperConnection Watcher:127.0.0.1:54698 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2162002 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2162002 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2162008 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2162010 T9729 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@17884b1b
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2162010 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2162022 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2163189 T9646 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54738_
[junit4] 2> 2163191 T9646 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:54738_
[junit4] 2> 2163202 T9646 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2163208 T9646 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005
[junit4] 2> 2164407 T9646 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005\conf\
[junit4] 2> 2164634 T9646 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2164638 T9646 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2164638 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2166396 T9646 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 4
[junit4] 2> 2166398 T9646 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2166401 T9646 oejs.AbstractConnector.doStart Started
[email protected]:54747
[junit4] 2> 2166403 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 2166403 T9646 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 2166403 T9646 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006
[junit4] 2> 2166403 T9646 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\'
[junit4] 2> 2166443 T9646 oasc.ConfigSolr.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\solr.xml
[junit4] 2> 2166456 T9646 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006
[junit4] 2> 2166456 T9646 oasc.CoreContainer.<init> New CoreContainer
403306991
[junit4] 2> 2166456 T9646 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\]
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting socketTimeout to: 90000
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting urlScheme to:
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting connTimeout to: 15000
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnectionsPerHost to: 20
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxConnections to: 10000
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting corePoolSize to: 0
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maximumPoolSize to: 2147483647
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting maxThreadIdleTime to: 5
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting sizeOfQueue to: -1
[junit4] 2> 2166458 T9646 oashc.HttpShardHandlerFactory.getParameter
Setting fairnessPolicy to: false
[junit4] 2> 2166458 T9646 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 2166461 T9646 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2166461 T9646 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2166461 T9646 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2166461 T9646 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:54698/solr
[junit4] 2> 2166461 T9646 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 2166461 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2166462 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2166464 T9742 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@a2b3f11 name:ZooKeeperConnection
Watcher:127.0.0.1:54698 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2166464 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2166464 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2166468 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2166469 T9745 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@3c535676
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2166470 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2166483 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2167649 T9646 oasc.ZkController.createEphemeralLiveNode
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54747_
[junit4] 2> 2167650 T9646 oascc.SolrZkClient.makePath makePath:
/live_nodes/127.0.0.1:54747_
[junit4] 2> 2167659 T9646 oasc.Overseer.close Overseer (id=null) closing
[junit4] 2> 2167664 T9646 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006
[junit4] 2> 2168942 T9646 oasc.CorePropertiesLocator.discoverUnder Found
core conf in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\conf\
[junit4] 2> 2169169 T9646 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 2169170 T9646 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2169170 T9646 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 2169175 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2169177 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2169183 T9749 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5fb35ae2
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2169183 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2169184 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2169186 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2169195 T9646
oasc.AbstractFullDistribZkTestBase.createCollection Creating collection with
stateFormat=2: delLiveColl
[junit4] 2> 2169196 T9646
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 2169197 T9646 oascc.ConnectionManager.waitForConnected Waiting
for client to connect to ZooKeeper
[junit4] 2> 2169199 T9752 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@66f81d96
name:ZooKeeperConnection Watcher:127.0.0.1:54698/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2169199 T9646 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 2169199 T9646 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 2169201 T9646
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 2169212 T9737 oasha.CollectionsHandler.handleCreateAction
Creating Collection :
replicationFactor=2&maxShardsPerNode=2&name=delLiveColl&action=CREATE&numShards=2&stateFormat=2&wt=javabin&version=2
[junit4] 2> 2169213 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/collection-queue-work state
SyncConnected
[junit4] 2> 2169215 T9674 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":"delLiveColl",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "stateFormat":"2"}
[junit4] 2> 2169216 T9753 oasc.OverseerCollectionProcessor.processMessage
WARN OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"delLiveColl",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "stateFormat":"2"}
[junit4] 2> 2169220 T9753 oasc.OverseerCollectionProcessor.createConfNode
Only one config set found in zk - using it:conf1
[junit4] 2> 2169220 T9753 oasc.OverseerCollectionProcessor.createConfNode
creating collections conf node /collections/delLiveColl
[junit4] 2> 2169221 T9753 oascc.SolrZkClient.makePath makePath:
/collections/delLiveColl
[junit4] 2> 2169233 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2169234 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"create",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"delLiveColl",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "stateFormat":"2"} current state version: 1
[junit4] 2> 2169235 T9673 oasco.ClusterStateMutator.createCollection
building a new cName: delLiveColl
[junit4] 2> 2169238 T9673 oasco.ZkStateWriter.writePendingUpdates going to
create_collection /collections/delLiveColl/state.json
[junit4] 2> 2169239 T9713 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> 2169239 T9679 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> 2169239 T9749 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> 2169240 T9697 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> 2169240 T9729 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> 2169241 T9672 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> 2169241 T9745 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> 2169241 T9752 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> 2169465 T9753
oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new
collection delLiveColl, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 2169465 T9753
oasc.OverseerCollectionProcessor.createCollection Creating shard
delLiveColl_shard1_replica1 as part of slice shard1 of collection delLiveColl
on 127.0.0.1:54747_
[junit4] 2> 2169466 T9753
oasc.OverseerCollectionProcessor.createCollection Creating shard
delLiveColl_shard1_replica2 as part of slice shard1 of collection delLiveColl
on 127.0.0.1:54705_
[junit4] 2> 2169468 T9753
oasc.OverseerCollectionProcessor.createCollection Creating shard
delLiveColl_shard2_replica1 as part of slice shard2 of collection delLiveColl
on 127.0.0.1:54729_
[junit4] 2> 2169471 T9739 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard1_replica1&action=CREATE&numShards=2&collection=delLiveColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 2169474 T9664 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard1_replica2&action=CREATE&numShards=2&collection=delLiveColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 2169477 T9753
oasc.OverseerCollectionProcessor.createCollection Creating shard
delLiveColl_shard2_replica2 as part of slice shard2 of collection delLiveColl
on 127.0.0.1:54738_
[junit4] 2> 2169481 T9723 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard2_replica2&action=CREATE&numShards=2&collection=delLiveColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 2169484 T9739 oasc.ZkController.publish publishing
core=delLiveColl_shard1_replica1 state=down collection=delLiveColl
[junit4] 2> 2169489 T9723 oasc.ZkController.publish publishing
core=delLiveColl_shard2_replica2 state=down collection=delLiveColl
[junit4] 2> 2169490 T9664 oasc.ZkController.publish publishing
core=delLiveColl_shard1_replica2 state=down collection=delLiveColl
[junit4] 2> 2169493 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2169495 T9739 oasc.ZkController.preRegister Registering watch
for external collection delLiveColl
[junit4] 2> 2169495 T9739 oascc.ZkStateReader.addZkWatch addZkWatch
delLiveColl
[junit4] 2> 2169496 T9739 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/delLiveColl/state.json from ZooKeeper...
[junit4] 2> 2169497 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"delLiveColl_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54747";,
[junit4] 2> "node_name":"127.0.0.1:54747_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 2169499 T9673 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"delLiveColl_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54747";,
[junit4] 2> "node_name":"127.0.0.1:54747_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"}
[junit4] 2> 2169502 T9723 oasc.ZkController.preRegister Registering watch
for external collection delLiveColl
[junit4] 2> 2169502 T9723 oascc.ZkStateReader.addZkWatch addZkWatch
delLiveColl
[junit4] 2> 2169503 T9723 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/delLiveColl/state.json from ZooKeeper...
[junit4] 2> 2169504 T9739 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 0
[junit4] 2> 2169504 T9739 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2169507 T9723 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 0
[junit4] 2> 2169507 T9723 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2169508 T9664 oasc.ZkController.preRegister Registering watch
for external collection delLiveColl
[junit4] 2> 2169511 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "core":"delLiveColl_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54738";,
[junit4] 2> "node_name":"127.0.0.1:54738_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 2169512 T9673 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"delLiveColl_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54738";,
[junit4] 2> "node_name":"127.0.0.1:54738_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"}
[junit4] 2> 2169515 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2169516 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 2, message = {
[junit4] 2> "core":"delLiveColl_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54705";,
[junit4] 2> "node_name":"127.0.0.1:54705_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 2169517 T9673 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"delLiveColl_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54705";,
[junit4] 2> "node_name":"127.0.0.1:54705_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"}
[junit4] 2> 2169534 T9705 oasha.CoreAdminHandler.handleCreateAction core
create command
qt=/admin/cores&collection.configName=conf1&name=delLiveColl_shard2_replica1&action=CREATE&numShards=2&collection=delLiveColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 2169540 T9705 oasc.ZkController.publish publishing
core=delLiveColl_shard2_replica1 state=down collection=delLiveColl
[junit4] 2> 2169543 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2169544 T9705 oasc.ZkController.preRegister Registering watch
for external collection delLiveColl
[junit4] 2> 2169546 T9705 oascc.ZkStateReader.addZkWatch addZkWatch
delLiveColl
[junit4] 2> 2169546 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "core":"delLiveColl_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54729";,
[junit4] 2> "node_name":"127.0.0.1:54729_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 2169547 T9705 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/delLiveColl/state.json from ZooKeeper...
[junit4] 2> 2169548 T9673 oasco.ReplicaMutator.updateState Update state
numShards=2 message={
[junit4] 2> "core":"delLiveColl_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:54729";,
[junit4] 2> "node_name":"127.0.0.1:54729_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"delLiveColl",
[junit4] 2> "operation":"state"}
[junit4] 2> 2169549 T9705 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 0
[junit4] 2> 2169550 T9705 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2169668 T9673 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/delLiveColl/state.json version: 0
[junit4] 2> 2169669 T9729 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2169670 T9745 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2169669 T9713 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2169671 T9729 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 1
[junit4] 2> 2169671 T9745 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 1
[junit4] 2> 2169672 T9713 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 1
[junit4] 2> 2169680 T9664 oascc.ZkStateReader.addZkWatch addZkWatch
delLiveColl
[junit4] 2> 2169681 T9664 oascc.ZkStateReader.addZkWatch Updating
collection state at /collections/delLiveColl/state.json from ZooKeeper...
[junit4] 2> 2169684 T9664 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 1
[junit4] 2> 2169684 T9664 oasc.ZkController.waitForCoreNodeName look for
our core node name
[junit4] 2> 2169684 T9664 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for delLiveColl_shard1_replica2
[junit4] 2> 2169684 T9664 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:delLiveColl
[junit4] 2> 2169686 T9664 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2169686 T9664 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/delLiveColl
[junit4] 2> 2169688 T9664 oascc.ZkStateReader.readConfigName
path=/collections/delLiveColl configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2169688 T9664 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\'
[junit4] 2> 2169722 T9664 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 2169729 T9664 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 2169742 T9664 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 2169746 T9664 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 2169759 T9664 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2169765 T9664 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 2169776 T9664 oass.IndexSchema.readSchema
[delLiveColl_shard1_replica2] Schema name=test
[junit4] 2> 2169873 T9664 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2169914 T9664 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2169915 T9664 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2169931 T9664 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2169935 T9664 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2169939 T9664 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2169941 T9664
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2169941 T9664
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2169942 T9664 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2169943 T9664
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2169944 T9664
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2169944 T9664 oasc.CoreContainer.create Creating SolrCore
'delLiveColl_shard1_replica2' using configuration from collection delLiveColl
[junit4] 2> 2169944 T9664 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2169946 T9664 oasc.SolrCore.<init>
[delLiveColl_shard1_replica2] Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\data\
[junit4] 2> 2169946 T9664 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@41008b8c
[junit4] 2> 2169947 T9664 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\data\
[junit4] 2> 2169947 T9664 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\data\index/
[junit4] 2> 2169947 T9664 oasc.SolrCore.initIndex WARN
[delLiveColl_shard1_replica2] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\data\index'
doesn't exist. Creating new index...
[junit4] 2> 2169948 T9664 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-002\delLiveColl_shard1_replica2\data\index
[junit4] 2> 2169948 T9664 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5429721641762935]
[junit4] 2> 2169949 T9664 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@36fc076
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51e990d4),segFN=segments_1,generation=1}
[junit4] 2> 2169949 T9664 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2169952 T9664 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 2169952 T9664 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 2169953 T9664 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2169953 T9664 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 2169953 T9664 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2169953 T9664 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 2169955 T9664 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 2169955 T9664 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2169956 T9664 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2169956 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2169957 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2169957 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2169957 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2169958 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 2169958 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 2169959 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 2169959 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 2169960 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 2169965 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 2169966 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 2169966 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 2169967 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 2169967 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 2169968 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 2169968 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 2169969 T9664 oasc.RequestHandlers.initHandlersFromConfig
created standard: solr.StandardRequestHandler
[junit4] 2> 2169969 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 2169970 T9664 oasc.RequestHandlers.initHandlersFromConfig
created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 2169976 T9664 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2169979 T9664 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2169980 T9664 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2169982 T9664 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2169983 T9664 oasc.SolrCore.initStatsCache Using default
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2169986 T9664 oasu.CommitTracker.<init> Hard AutoCommit:
disabled
[junit4] 2> 2169987 T9664 oasu.CommitTracker.<init> Soft AutoCommit:
disabled
[junit4] 2> 2169987 T9664 oasu.RandomMergePolicy.<init> RandomMergePolicy
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=39, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 2169988 T9664 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@36fc076
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51e990d4),segFN=segments_1,generation=1}
[junit4] 2> 2169988 T9664 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 2169989 T9664 oass.SolrIndexSearcher.<init> Opening
Searcher@1a1cce76[delLiveColl_shard1_replica2] main
[junit4] 2> 2169989 T9664 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/delLiveColl
[junit4] 2> 2169990 T9664 oascc.ZkStateReader.readConfigName
path=/collections/delLiveColl configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2169990 T9664 oasr.ManagedResourceStorage.newStorageIO Setting
up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 2169992 T9664
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2169993 T9664 oasr.RestManager.init Initializing RestManager
with initArgs: {}
[junit4] 2> 2169993 T9664 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2169994 T9664
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 2169994 T9664 oasr.ManagedResourceStorage.load Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2169994 T9664 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 2169994 T9664 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 2169996 T9758 oasc.SolrCore.registerSearcher
[delLiveColl_shard1_replica2] Registered new searcher
Searcher@1a1cce76[delLiveColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2169996 T9664 oasc.CoreContainer.registerCore registering
core: delLiveColl_shard1_replica2
[junit4] 2> 2169996 T9664 oasc.ZkController.register Register replica -
core:delLiveColl_shard1_replica2 address:http://127.0.0.1:54705
collection:delLiveColl shard:shard1
[junit4] 2> 2169998 T9664 oascc.SolrZkClient.makePath makePath:
/collections/delLiveColl/leader_elect/shard1/election
[junit4] 2> 2170007 T9664 oasc.ShardLeaderElectionContext.runLeaderProcess
Running the leader process for shard shard1
[junit4] 2> 2170010 T9672 oasc.DistributedQueue$LatchWatcher.process
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
[junit4] 2> 2170011 T9664
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Waiting until we see
more replicas up for shard shard1: total=2 found=1 timeoutin=179999ms
[junit4] 2> 2170012 T9673 oasc.Overseer$ClusterStateUpdater.run
processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"delLiveColl"} current state version: 2
[junit4] 2> 2170131 T9673 oasco.ZkStateWriter.writePendingUpdates going to
update_collection /collections/delLiveColl/state.json version: 1
[junit4] 2> 2170132 T9672 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2170133 T9729 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2170133 T9745 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2170132 T9713 oascc.ZkStateReader$7.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/delLiveColl/state.json, has occurred - updating...
[junit4] 2> 2170134 T9745 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 2
[junit4] 2> 2170135 T9729 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 2
[junit4] 2> 2170135 T9713 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 2
[junit4] 2> 2170138 T9672 oascc.ZkStateReader.updateWatchedCollection
Updating data for delLiveColl to ver 2
[junit4] 2> 2170655 T9739 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for delLiveColl_shard1_replica1
[junit4] 2> 2170655 T9739 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:delLiveColl
[junit4] 2> 2170656 T9739 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2170656 T9739 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/delLiveColl
[junit4] 2> 2170658 T9739 oascc.ZkStateReader.readConfigName
path=/collections/delLiveColl configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2170658 T9739 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\delLiveColl_shard1_replica1\'
[junit4] 2> 2170678 T9739 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 2170678 T9723 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for delLiveColl_shard2_replica2
[junit4] 2> 2170679 T9723 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:delLiveColl
[junit4] 2> 2170682 T9723 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2170682 T9723 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/delLiveColl
[junit4] 2> 2170683 T9739 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 2170685 T9723 oascc.ZkStateReader.readConfigName
path=/collections/delLiveColl configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2170685 T9723 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-005\delLiveColl_shard2_replica2\'
[junit4] 2> 2170692 T9739 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 2170697 T9739 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 2170706 T9723 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 2170707 T9739 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2170709 T9705 oasc.ZkController.waitForShardId waiting to find
shard id in clusterstate for delLiveColl_shard2_replica1
[junit4] 2> 2170709 T9705 oasc.ZkController.createCollectionZkNode Check
for collection zkNode:delLiveColl
[junit4] 2> 2170711 T9739 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 2170714 T9723 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 2170716 T9705 oasc.ZkController.createCollectionZkNode
Collection zkNode exists
[junit4] 2> 2170716 T9705 oascc.ZkStateReader.readConfigName Load
collection config from:/collections/delLiveColl
[junit4] 2> 2170719 T9739 oass.IndexSchema.readSchema
[delLiveColl_shard1_replica1] Schema name=test
[junit4] 2> 2170724 T9705 oascc.ZkStateReader.readConfigName
path=/collections/delLiveColl configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2170724 T9705 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-004\delLiveColl_shard2_replica1\'
[junit4] 2> 2170746 T9705 oasc.ZkController.watchZKConfDir watch zkdir
/configs/conf1
[junit4] 2> 2170749 T9723 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 2170755 T9723 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 2170764 T9723 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2170770 T9705 oasc.Config.<init> loaded config solrconfig.xml
with version 0
[junit4] 2> 2170771 T9723 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 2170778 T9723 oass.IndexSchema.readSchema
[delLiveColl_shard2_replica2] Schema name=test
[junit4] 2> 2170823 T9739 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2170828 T9739 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2170829 T9739 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2170870 T9705 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 2170876 T9705 oasc.SolrConfig.<init> Using Lucene
MatchVersion: 6.0.0
[junit4] 2> 2170886 T9705 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 2170893 T9705 oass.IndexSchema.readSchema Reading Solr Schema
from /configs/conf1/schema.xml
[junit4] 2> 2170898 T9723 oass.OpenExchangeRatesOrgProvider.init
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2170898 T9705 oass.IndexSchema.readSchema
[delLiveColl_shard2_replica1] Schema name=test
[junit4] 2> 2170903 T9723 oass.IndexSchema.readSchema default search field
in schema is text
[junit4] 2> 2170904 T9723 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2170937 T9739 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2170942 T9739 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2170949 T9739 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2170952 T9723 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2170954 T9739
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2170954 T9739
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2170954 T9739 oass.OpenExchangeRatesOrgProvider.reload
Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 2170958 T9723 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 2170961 T9739
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 2170961 T9739
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 2170962 T9739 oasc.CoreContainer.create Creating SolrCore
'delLiveColl_shard1_replica1' using configuration from collection delLiveColl
[junit4] 2> 2170962 T9739 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2170962 T9739 oasc.SolrCore.<init>
[delLiveColl_shard1_replica1] Opening new SolrCore at
..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\delLiveColl_shard1_replica1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\delLiveColl_shard1_replica1\data\
[junit4] 2> 2170962 T9739 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@41008b8c
[junit4] 2> 2170964 T9739 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\
[...truncated too long message...]
cene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001\tempDir-006\delLiveColl_shard1_replica1\data\index
[junit4] 2> 2180890 T9646 oasc.Overseer.close Overseer
(id=93068725233385485-127.0.0.1:54747_-n_0000000004) closing
[junit4] 2> 2180890 T9793 oasc.Overseer$ClusterStateUpdater.run Overseer
Loop exiting : 127.0.0.1:54747_
[junit4] 2> 2180895 T9648 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14aa583333c000d, 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> 2182418 T9745 oascc.ZkStateReader$7.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 2182418 T9778 oascc.ZkStateReader$3.process WARN ZooKeeper
watch triggered, but Solr cannot talk to ZK
[junit4] 2> 2182433 T9646 oejsh.ContextHandler.doStop stopped
o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 2182641 T9646 oas.SolrTestCaseJ4.tearDown ###Ending
testDistribSearch
[junit4] 2> 2182643 T9646 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:54698 54698
[junit4] 2> 2185125 T9647 oasc.ZkTestServer.send4LetterWord connecting to
127.0.0.1:54698 54698
[junit4] 2> 2185128 T9647 oasc.ZkTestServer$ZKServerMain.runFromConfig
WARN Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/aliases.json
[junit4] 2> 8 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/delLiveColl/state.json
[junit4] 2> 4 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/live_nodes
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 4 /solr/overseer/queue
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DeleteReplicaTest
-Dtests.method=testDistribSearch -Dtests.seed=DE0AD8B60000011D
-Dtests.slow=true -Dtests.locale=fr_LU -Dtests.timezone=Europe/Belfast
-Dtests.asserts=false -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 34.9s | DeleteReplicaTest.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.AssertionError: Should have had a good
message here
[junit4] > at
__randomizedtesting.SeedInfo.seed([DE0AD8B60000011D:5FEC56AE775F6121]:0)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.deleteLiveReplicaTest(DeleteReplicaTest.java:138)
[junit4] > at
org.apache.solr.cloud.DeleteReplicaTest.doTest(DeleteReplicaTest.java:89)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:868)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2185148 T9646 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.DeleteReplicaTest-DE0AD8B60000011D-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {},
locale=fr_LU, timezone=Europe/Belfast
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40-ea
(64-bit)/cpus=2,threads=1,free=348615928,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [DeleteShardTest,
BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, TestSolrJ,
FileUtilsTest, MBeansHandlerTest, TestFieldCollectionResource,
URLClassifyProcessorTest, UpdateRequestProcessorFactoryTest, SSLMigrationTest,
TestRangeQuery, TestManagedSchemaDynamicFieldResource, DistribCursorPagingTest,
TestSchemaNameResource, TestStressReorder, SoftAutoCommitTest,
TestPHPSerializedResponseWriter, SuggesterFSTTest, OutputWriterTest,
MoreLikeThisHandlerTest, TestLMDirichletSimilarityFactory,
PathHierarchyTokenizerFactoryTest, JSONWriterTest,
TestSchemaSimilarityResource, ZkCLITest, TestConfigReload, RollingRestartTest,
HdfsCollectionsAPIDistributedZkTest, LeaderInitiatedRecoveryOnCommitTest,
ClusterStateUpdateTest, SimpleCollectionCreateDeleteTest,
XsltUpdateRequestHandlerTest, TestClassNameShortening, DistributedQueueTest,
TestDynamicFieldResource, TestBlendedInfixSuggestions, BasicFunctionalityTest,
SolrCoreTest, TestCharFilters, SpellingQueryConverterTest, RankQueryTest,
SpellCheckCollatorTest, DistributedDebugComponentTest,
TestHighFrequencyDictionaryFactory, SuggestComponentTest, ModifyConfFileTest,
TestShardHandlerFactory, SliceStateTest, ClusterStateTest,
OverriddenZkACLAndCredentialsProvidersTest, RequestHandlersTest,
TestDynamicFieldCollectionResource, TestExtendedDismaxParser,
TestIndexSearcher, TestFastWriter, RemoteQueryErrorTest, TestWriterPerf,
TestSolr4Spatial, TestClusterStateMutator,
TestOverriddenPrefixQueryForCustomFieldType, BasicZkTest, UpdateParamsTest,
CircularListTest, TestXIncludeConfig, TestAddFieldRealTimeGet,
OpenCloseCoreStressTest, ScriptEngineTest, HdfsLockFactoryTest,
CoreAdminRequestStatusTest, TestSolrConfigHandler, SolrTestCaseJ4Test,
DocValuesMissingTest, CollectionsAPIDistributedZkTest,
LegacyHTMLStripCharFilterTest, StatelessScriptUpdateProcessorFactoryTest,
TestExceedMaxTermLength, TestReversedWildcardFilterFactory, TestNRTOpen,
AutoCommitTest, CursorMarkTest, ShardRoutingCustomTest,
TestFreeTextSuggestions, TestQuerySenderNoQuery,
DistributedIntervalFacetingTest, BasicDistributedZk2Test, TestSearcherReuse,
BlockDirectoryTest, ZkSolrClientTest, TestManagedResourceStorage,
UnloadDistributedZkTest, TestSolrXmlPersistor,
DistributedFacetPivotLongTailTest, OverseerTest,
TestManagedSynonymFilterFactory, HdfsWriteToMultipleCollectionsTest,
DirectSolrConnectionTest, SynonymTokenizerTest, TestManagedSchema,
IndexSchemaTest, TestStressLucene, TestFileDictionaryLookup,
DistributedSuggestComponentTest, OverseerRolesTest, TestRecovery,
TestQuerySenderListener, TestCollationFieldDocValues,
UUIDUpdateProcessorFallbackTest, TestSolrXmlPersistence, SampleTest,
CustomCollectionTest, DebugComponentTest, TestSolrQueryParserResource,
IndexSchemaRuntimeFieldTest, TestSolrDynamicMBean,
DistributedExpandComponentTest, AsyncMigrateRouteKeyTest, MergeStrategyTest,
TestCloudPivotFacet, CacheHeaderTest, DOMUtilTest, TestTolerantSearch,
BadComponentTest, TestCustomSort, TestFastOutputStream, TestSolrIndexConfig,
SystemInfoHandlerTest, TestMissingGroups, ShardSplitTest, PreAnalyzedFieldTest,
ExitableDirectoryReaderTest, TestPartialUpdateDeduplication,
MultiThreadedOCPTest, TestSchemaVersionResource, TestRecoveryHdfs, TestSort,
TestSolr4Spatial2, LukeRequestHandlerTest, DateFieldTest,
TestSolrDeletionPolicy1, TestReload, TestManagedSchemaFieldResource,
TestNoOpRegenerator, ExternalFileFieldSortTest, TestPerFieldSimilarity,
ReplicationFactorTest, TestArbitraryIndexDir,
TestSolrQueryParserDefaultOperatorResource, SolrInfoMBeanTest,
TestSimpleQParserPlugin, ShardRoutingTest, RAMDirectoryFactoryTest,
DocumentBuilderTest, TestBM25SimilarityFactory, DocValuesTest, TestTrie,
SharedFSAutoReplicaFailoverUtilsTest, TestBadConfig,
TestAtomicUpdateErrorCases, TestDocBasedVersionConstraints,
TestFieldTypeCollectionResource, XmlUpdateRequestHandlerTest,
TestSolrQueryParser, DateMathParserTest, UUIDFieldTest,
QueryElevationComponentTest, LeaderElectionTest, ZkStateWriterTest,
TestFieldSortValues, SpellCheckComponentTest, TestRandomFaceting,
NotRequiredUniqueKeyTest, TestQueryTypes, NoCacheHeaderTest,
LeaderFailoverAfterPartitionTest, TestZkChroot, TestConfigSets, RecoveryZkTest,
JsonLoaderTest, BJQParserTest, StatsComponentTest, TestDistributedMissingSort,
CachingDirectoryFactoryTest, HardAutoCommitTest, CurrencyFieldXmlFileTest,
MinimalSchemaTest, SimpleMLTQParserTest, HttpPartitionTest,
SignatureUpdateProcessorFactoryTest, SchemaVersionSpecificBehaviorTest,
LeaderElectionIntegrationTest, TestSolrDeletionPolicy2, TestInitParams,
DirectUpdateHandlerTest, TestDefaultStatsCache, TestSurroundQueryParser,
TestReloadAndDeleteDocs, TestConfig, UniqFieldsUpdateProcessorFactoryTest,
DeleteReplicaTest]
[junit4] Completed in 34.90s, 1 test, 1 failure <<< FAILURES!
[...truncated 782 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:519: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:187:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:510:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1349:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:956:
There were test failures: 460 suites, 1857 tests, 1 failure, 56 ignored (31
assumptions)
Total time: 104 minutes 10 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b09
-XX:+UseCompressedOops -XX:+UseG1GC (asserts: false)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
