Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4739/
Java: 64bit/jdk1.8.0_45 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([C24CF0BC50F6DDA3]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([C24CF0BC50F6DDA3]:0)
Build Log:
[...truncated 10945 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\init-core-data-001
[junit4] 2> 1632454 T11959
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system
property: /
[junit4] 2> 1632455 T11959 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 1632456 T11960 oasc.ZkTestServer$2$1.setClientPort client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1632456 T11960 oasc.ZkTestServer$ZKServerMain.runFromConfig
Starting server
[junit4] 2> 1632521 T11959 oasc.ZkTestServer.run start zk server on
port:50413
[junit4] 2> 1632521 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1632522 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1632524 T11967 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@5dfec272
name:ZooKeeperConnection Watcher:127.0.0.1:50413 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1632524 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1632524 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1632524 T11959 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 1632526 T11961 oazs.NIOServerCnxn.doIO WARN caught end of
stream exception EndOfStreamException: Unable to read additional data from
client sessionid 0x14cff5853d30000, 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> 1632526 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1632528 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1632529 T11970 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@9312249 name:ZooKeeperConnection
Watcher:127.0.0.1:50413/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1632529 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1632529 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1632529 T11959 oascc.SolrZkClient.makePath makePath:
/collections/collection1
[junit4] 2> 1632531 T11959 oascc.SolrZkClient.makePath makePath:
/collections/collection1/shards
[junit4] 2> 1632533 T11959 oascc.SolrZkClient.makePath makePath:
/collections/control_collection
[junit4] 2> 1632534 T11959 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/shards
[junit4] 2> 1632536 T11959 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> 1632536 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.xml
[junit4] 2> 1632539 T11959 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> 1632539 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/schema.xml
[junit4] 2> 1632541 T11959 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> 1632541 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1632543 T11959 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> 1632544 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/stopwords.txt
[junit4] 2> 1632545 T11959 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> 1632546 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/protwords.txt
[junit4] 2> 1632548 T11959 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> 1632548 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/currency.xml
[junit4] 2> 1632550 T11959 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> 1632550 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/enumsConfig.xml
[junit4] 2> 1632551 T11959 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> 1632552 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/open-exchange-rates.json
[junit4] 2> 1632553 T11959 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> 1632553 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1632555 T11959 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> 1632555 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/old_synonyms.txt
[junit4] 2> 1632557 T11959 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> 1632557 T11959 oascc.SolrZkClient.makePath makePath:
/configs/conf1/synonyms.txt
[junit4] 2> 1632749 T11959 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1
[junit4] 2> 1632751 T11959 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1632753 T11959 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@68916c9a{/,null,AVAILABLE}
[junit4] 2> 1632753 T11959 oejs.AbstractConnector.doStart Started
ServerConnector@44abf1ec{HTTP/1.1}{127.0.0.1:50431}
[junit4] 2> 1632754 T11959 oejs.Server.doStart Started @1642181ms
[junit4] 2> 1632754 T11959 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties:
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\tempDir-001/control/data, hostContext=/, hostPort=50430,
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores}
[junit4] 2> 1632754 T11959 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1632755 T11959 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\'
[junit4] 2> 1632779 T11959 oasc.SolrXmlConfig.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\solr.xml
[junit4] 2> 1632784 T11959 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores
[junit4] 2> 1632785 T11959 oasc.CoreContainer.<init> New CoreContainer
492205814
[junit4] 2> 1632785 T11959 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\]
[junit4] 2> 1632785 T11959 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\lib
[junit4] 2> 1632786 T11959 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\lib).
[junit4] 2> 1632793 T11959 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1632796 T11959 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1632796 T11959 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1632796 T11959 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1632797 T11959 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1632797 T11959 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:50413/solr
[junit4] 2> 1632797 T11959 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1632797 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1632798 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1632799 T11984 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4c2fffd1
name:ZooKeeperConnection Watcher:127.0.0.1:50413 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1632799 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1632799 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1632801 T11959 n:127.0.0.1:50430_
oascc.ConnectionManager.waitForConnected Waiting for client to connect to
ZooKeeper
[junit4] 2> 1632802 T11987 n:127.0.0.1:50430_
oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@79ea6eef
name:ZooKeeperConnection Watcher:127.0.0.1:50413/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1632803 T11959 n:127.0.0.1:50430_
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1632804 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/queue
[junit4] 2> 1632806 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/collection-queue-work
[junit4] 2> 1632808 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/collection-map-running
[junit4] 2> 1632810 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/collection-map-completed
[junit4] 2> 1632813 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/collection-map-failure
[junit4] 2> 1632814 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /live_nodes
[junit4] 2> 1632817 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /aliases.json
[junit4] 2> 1632818 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /clusterstate.json
[junit4] 2> 1632820 T11959 n:127.0.0.1:50430_
oasc.ZkController.createEphemeralLiveNode Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50430_
[junit4] 2> 1632820 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /live_nodes/127.0.0.1:50430_
[junit4] 2> 1632821 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer_elect
[junit4] 2> 1632823 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer_elect/election
[junit4] 2> 1632825 T11959 n:127.0.0.1:50430_ oasc.Overseer.close Overseer
(id=null) closing
[junit4] 2> 1632826 T11959 n:127.0.0.1:50430_
oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader
127.0.0.1:50430_
[junit4] 2> 1632826 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer_elect/leader
[junit4] 2> 1632828 T11959 n:127.0.0.1:50430_ oasc.Overseer.start Overseer
(id=93730447096479747-127.0.0.1:50430_-n_0000000000) starting
[junit4] 2> 1632829 T11959 n:127.0.0.1:50430_ oascc.SolrZkClient.makePath
makePath: /overseer/queue-work
[junit4] 2> 1632835 T11959 n:127.0.0.1:50430_
oasc.OverseerAutoReplicaFailoverThread.<init> Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1632836 T11959 n:127.0.0.1:50430_
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1632836 T11989 n:127.0.0.1:50430_
oasc.OverseerCollectionProcessor.run Process current queue of collection
creations
[junit4] 2> 1632837 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 1632840 T11959 n:127.0.0.1:50430_
oasc.CorePropertiesLocator.discover Looking for core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores
[junit4] 2> 1632842 T11959 n:127.0.0.1:50430_ oasc.CoreDescriptor.<init>
CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false,
schema=schema.xml, loadOnStartup=true,
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1,
collection=control_collection,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\, coreNodeName=,
dataDir=data\, shard=}
[junit4] 2> 1632842 T11959 n:127.0.0.1:50430_
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\
[junit4] 2> 1632842 T11959 n:127.0.0.1:50430_
oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1632843 T11991 n:127.0.0.1:50430_ c:control_collection
x:collection1 oasc.ZkController.publish publishing core=collection1 state=down
collection=control_collection
[junit4] 2> 1632843 T11991 n:127.0.0.1:50430_ c:control_collection
x:collection1 oasc.ZkController.publish numShards not found on descriptor -
reading it from system property
[junit4] 2> 1632843 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1632843 T11991 n:127.0.0.1:50430_
oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1632844 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50430";,
[junit4] 2> "node_name":"127.0.0.1:50430_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1632845 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50430";,
[junit4] 2> "node_name":"127.0.0.1:50430_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1632845 T11988 n:127.0.0.1:50430_
oasco.ClusterStateMutator.createCollection building a new cName:
control_collection
[junit4] 2> 1632845 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1632846 T11987 n:127.0.0.1:50430_
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> 1633489 T11991 n:127.0.0.1:50430_
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for
collection1
[junit4] 2> 1633489 T11991 n:127.0.0.1:50430_
oasc.ZkController.createCollectionZkNode Check for collection
zkNode:control_collection
[junit4] 2> 1633490 T11991 n:127.0.0.1:50430_
oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1633490 T11991 n:127.0.0.1:50430_
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/control_collection
[junit4] 2> 1633490 T11991 n:127.0.0.1:50430_
oascc.ZkStateReader.readConfigName path=/collections/control_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1633490 T11991 n:127.0.0.1:50430_
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\'
[junit4] 2> 1633505 T11991 n:127.0.0.1:50430_ oasc.Config.<init> loaded
config solrconfig.xml with version 0
[junit4] 2> 1633511 T11991 n:127.0.0.1:50430_
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1633513 T11991 n:127.0.0.1:50430_ oasc.SolrConfig.<init> Using
Lucene MatchVersion: 6.0.0
[junit4] 2> 1633519 T11991 n:127.0.0.1:50430_ oasc.SolrConfig.<init>
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1633520 T11991 n:127.0.0.1:50430_ oass.IndexSchema.readSchema
Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1633525 T11991 n:127.0.0.1:50430_ oass.IndexSchema.readSchema
[collection1] Schema name=test
[junit4] 2> 1633595 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1633600 T11991 n:127.0.0.1:50430_ oass.IndexSchema.readSchema
default search field in schema is text
[junit4] 2> 1633601 T11991 n:127.0.0.1:50430_ oass.IndexSchema.readSchema
unique key field: id
[junit4] 2> 1633608 T11991 n:127.0.0.1:50430_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1633610 T11991 n:127.0.0.1:50430_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1633611 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1633612 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1633612 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1633612 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ oasc.CoreContainer.create
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\], dataDir=[null]
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6b68dff1
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\data\
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.getNewIndexDir New index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\data\index/
[junit4] 2> 1633613 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.initIndex WARN [collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\data\index' doesn't exist.
Creating new index...
[junit4] 2> 1633614 T11991 n:127.0.0.1:50430_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\control-001\cores\collection1\data\index
[junit4] 2> 1633614 T11991 n:127.0.0.1:50430_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=79.8349609375,
floorSegmentMB=1.30859375, forceMergeDeletesPctAllowed=6.492591399084552,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1633614 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@4bcd403b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@783207fa),segFN=segments_1,generation=1}
[junit4] 2> 1633615 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1633617 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1633617 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1633618 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 1633620 T11991 n:127.0.0.1:50430_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1633622 T11991 n:127.0.0.1:50430_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1633622 T11991 n:127.0.0.1:50430_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1633623 T11991 n:127.0.0.1:50430_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1633625 T11991 n:127.0.0.1:50430_ x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1633625 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.initStatsCache Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1633626 T11991 n:127.0.0.1:50430_ x:collection1
oasu.UpdateHandler.<init> Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1633626 T11991 n:127.0.0.1:50430_ x:collection1
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=22, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=56.4921875,
floorSegmentMB=1.5576171875, forceMergeDeletesPctAllowed=5.838031642506935,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@4bcd403b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@783207fa),segFN=segments_1,generation=1}
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oass.SolrIndexSearcher.<init> Opening Searcher@3f210b38[collection1] main
[junit4] 2> 1633627 T11991 n:127.0.0.1:50430_ x:collection1
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/control_collection
[junit4] 2> 1633628 T11991 n:127.0.0.1:50430_ x:collection1
oascc.ZkStateReader.readConfigName path=/collections/control_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1633628 T11991 n:127.0.0.1:50430_ x:collection1
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for
the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.ManagedResourceStorage.load Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1633629 T11991 n:127.0.0.1:50430_ x:collection1
oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1633630 T11991 n:127.0.0.1:50430_ x:collection1
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
[junit4] 2> 1633630 T11992 n:127.0.0.1:50430_ x:collection1
oasc.SolrCore.registerSearcher [collection1] Registered new searcher
Searcher@3f210b38[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1633630 T11991 n:127.0.0.1:50430_ x:collection1
oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1633630 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.register Register replica -
core:collection1 address:http://127.0.0.1:50430 collection:control_collection
shard:shard1
[junit4] 2> 1633631 T11959 n:127.0.0.1:50430_ oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1633631 T11959 n:127.0.0.1:50430_ oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1633632 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1633633 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1633634 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1633635 T11999 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@513be61b
name:ZooKeeperConnection Watcher:127.0.0.1:50413/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1633635 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1633635 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1633636 T11959
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1633636 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running
the leader process for shard shard1
[junit4] 2> 1633637 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1633637 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp
Enough replicas found to continue.
[junit4] 2> 1633637 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may
be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2230 name=collection1
org.apache.solr.core.SolrCore@54eebe8 url=http://127.0.0.1:50430/collection1
node=127.0.0.1:50430_ C2230_STATE=coll:control_collection core:collection1
props:{core=collection1, base_url=http://127.0.0.1:50430,
node_name=127.0.0.1:50430_, state=down}
[junit4] 2> 1633637 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 C2230 oasc.SyncStrategy.sync Sync replicas to
http://127.0.0.1:50430/collection1/
[junit4] 2> 1633637 T11959 oasc.ChaosMonkey.monkeyLog monkey: init -
expire sessions:false cause connection loss:false
[junit4] 2> 1633637 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 C2230 oasc.SyncStrategy.syncReplicas Sync Success - now
sync replicas to me
[junit4] 2> 1633638 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 C2230 oasc.SyncStrategy.syncToMe
http://127.0.0.1:50430/collection1/ has no replicas
[junit4] 2> 1633638 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am
the new leader: http://127.0.0.1:50430/collection1/ shard1
[junit4] 2> 1633638 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 1633638 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state
version: 1
[junit4] 2> 1633641 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1633642 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:50430";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1633709 T11987 n:127.0.0.1:50430_
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> 1633709 T11999 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> 1633741 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.register We are
http://127.0.0.1:50430/collection1/ and leader is
http://127.0.0.1:50430/collection1/
[junit4] 2> 1633741 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.register No LogReplay needed for
core=collection1 baseURL=http://127.0.0.1:50430
[junit4] 2> 1633741 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.checkRecovery I am the leader, no
recovery necessary
[junit4] 2> 1633741 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.publish publishing core=collection1
state=active collection=control_collection
[junit4] 2> 1633741 T11995 n:127.0.0.1:50430_ c:control_collection
s:shard1 x:collection1 oasc.ZkController.publish numShards not found on
descriptor - reading it from system property
[junit4] 2> 1633743 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1633745 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50430";,
[junit4] 2> "node_name":"127.0.0.1:50430_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1633745 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50430";,
[junit4] 2> "node_name":"127.0.0.1:50430_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1633812 T11999 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> 1633812 T11987 n:127.0.0.1:50430_
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> 1633826 T11959 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1
[junit4] 2> 1633828 T11959 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 1 in directory
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001
[junit4] 2> 1633829 T11959 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1633831 T11959 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@6bd2b956{/,null,AVAILABLE}
[junit4] 2> 1633832 T11959 oejs.AbstractConnector.doStart Started
ServerConnector@625b0723{HTTP/1.1}{127.0.0.1:50444}
[junit4] 2> 1633832 T11959 oejs.Server.doStart Started @1643860ms
[junit4] 2> 1633832 T11959 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties:
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\tempDir-001/jetty1, solrconfig=solrconfig.xml,
hostContext=/, hostPort=50443,
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores}
[junit4] 2> 1633833 T11959 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1633834 T11959 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\'
[junit4] 2> 1633857 T11959 oasc.SolrXmlConfig.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\solr.xml
[junit4] 2> 1633865 T11959 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores
[junit4] 2> 1633865 T11959 oasc.CoreContainer.<init> New CoreContainer
1933100353
[junit4] 2> 1633866 T11959 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\]
[junit4] 2> 1633866 T11959 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\lib
[junit4] 2> 1633866 T11959 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\lib).
[junit4] 2> 1633874 T11959 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1633876 T11959 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1633878 T11959 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1633878 T11959 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1633878 T11959 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1633878 T11959 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:50413/solr
[junit4] 2> 1633879 T11959 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1633879 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1633880 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1633882 T12013 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@106b4c0f
name:ZooKeeperConnection Watcher:127.0.0.1:50413 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1633882 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1633883 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1633885 T11959 n:127.0.0.1:50443_
oascc.ConnectionManager.waitForConnected Waiting for client to connect to
ZooKeeper
[junit4] 2> 1633886 T12016 n:127.0.0.1:50443_
oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@2b02ff72
name:ZooKeeperConnection Watcher:127.0.0.1:50413/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1633886 T11959 n:127.0.0.1:50443_
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1633892 T11959 n:127.0.0.1:50443_
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1634542 T11959 n:127.0.0.1:50443_
oasc.ZkController.createEphemeralLiveNode Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50443_
[junit4] 2> 1634542 T11959 n:127.0.0.1:50443_ oascc.SolrZkClient.makePath
makePath: /live_nodes/127.0.0.1:50443_
[junit4] 2> 1634545 T11959 n:127.0.0.1:50443_ oasc.Overseer.close Overseer
(id=null) closing
[junit4] 2> 1634547 T11959 n:127.0.0.1:50443_
oasc.CorePropertiesLocator.discover Looking for core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores
[junit4] 2> 1634547 T11959 n:127.0.0.1:50443_ oasc.CoreDescriptor.<init>
CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false,
schema=schema.xml, loadOnStartup=true,
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1, collection=collection1,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\, coreNodeName=,
dataDir=data\, shard=}
[junit4] 2> 1634548 T11959 n:127.0.0.1:50443_
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\
[junit4] 2> 1634548 T11959 n:127.0.0.1:50443_
oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1634549 T12017 n:127.0.0.1:50443_ c:collection1 x:collection1
oasc.ZkController.publish publishing core=collection1 state=down
collection=collection1
[junit4] 2> 1634549 T12017 n:127.0.0.1:50443_ c:collection1 x:collection1
oasc.ZkController.publish numShards not found on descriptor - reading it from
system property
[junit4] 2> 1634550 T12017 n:127.0.0.1:50443_
oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1634550 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1634551 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50443";,
[junit4] 2> "node_name":"127.0.0.1:50443_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 1634551 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50443";,
[junit4] 2> "node_name":"127.0.0.1:50443_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1634551 T11988 n:127.0.0.1:50430_
oasco.ClusterStateMutator.createCollection building a new cName: collection1
[junit4] 2> 1634551 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1634618 T12016 n:127.0.0.1:50443_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1634618 T11999 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1634618 T11987 n:127.0.0.1:50430_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1635196 T12017 n:127.0.0.1:50443_
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for
collection1
[junit4] 2> 1635196 T12017 n:127.0.0.1:50443_
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1635196 T12017 n:127.0.0.1:50443_
oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1635196 T12017 n:127.0.0.1:50443_
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/collection1
[junit4] 2> 1635198 T12017 n:127.0.0.1:50443_
oascc.ZkStateReader.readConfigName path=/collections/collection1
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1635198 T12017 n:127.0.0.1:50443_
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\'
[junit4] 2> 1635213 T12017 n:127.0.0.1:50443_ oasc.Config.<init> loaded
config solrconfig.xml with version 0
[junit4] 2> 1635218 T12017 n:127.0.0.1:50443_
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1635221 T12017 n:127.0.0.1:50443_ oasc.SolrConfig.<init> Using
Lucene MatchVersion: 6.0.0
[junit4] 2> 1635228 T12017 n:127.0.0.1:50443_ oasc.SolrConfig.<init>
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1635230 T12017 n:127.0.0.1:50443_ oass.IndexSchema.readSchema
Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1635232 T12017 n:127.0.0.1:50443_ oass.IndexSchema.readSchema
[collection1] Schema name=test
[junit4] 2> 1635291 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1635298 T12017 n:127.0.0.1:50443_ oass.IndexSchema.readSchema
default search field in schema is text
[junit4] 2> 1635299 T12017 n:127.0.0.1:50443_ oass.IndexSchema.readSchema
unique key field: id
[junit4] 2> 1635307 T12017 n:127.0.0.1:50443_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1635309 T12017 n:127.0.0.1:50443_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1635310 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1635311 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1635311 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1635312 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1635312 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1635312 T12017 n:127.0.0.1:50443_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1635312 T12017 n:127.0.0.1:50443_ oasc.CoreContainer.create
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 1635312 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1635313 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\], dataDir=[null]
[junit4] 2> 1635313 T12017 n:127.0.0.1:50443_ x:collection1
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6b68dff1
[junit4] 2> 1635313 T12017 n:127.0.0.1:50443_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\data\
[junit4] 2> 1635313 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.getNewIndexDir New index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\data\index/
[junit4] 2> 1635313 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.initIndex WARN [collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\data\index' doesn't exist.
Creating new index...
[junit4] 2> 1635314 T12017 n:127.0.0.1:50443_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-1-001\cores\collection1\data\index
[junit4] 2> 1635314 T12017 n:127.0.0.1:50443_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=79.8349609375,
floorSegmentMB=1.30859375, forceMergeDeletesPctAllowed=6.492591399084552,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1635314 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@64ed4d9c
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@26dbdf58),segFN=segments_1,generation=1}
[junit4] 2> 1635314 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1635317 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1635318 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1635318 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1635318 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1635318 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1635319 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 1635319 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1635319 T12017 n:127.0.0.1:50443_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1635319 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 1635320 T12017 n:127.0.0.1:50443_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1635322 T12017 n:127.0.0.1:50443_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1635322 T12017 n:127.0.0.1:50443_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1635323 T12017 n:127.0.0.1:50443_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1635326 T12017 n:127.0.0.1:50443_ x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1635326 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.initStatsCache Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1635327 T12017 n:127.0.0.1:50443_ x:collection1
oasu.UpdateHandler.<init> Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1635327 T12017 n:127.0.0.1:50443_ x:collection1
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10
[junit4] 2> 1635328 T12017 n:127.0.0.1:50443_ x:collection1
oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1635328 T12017 n:127.0.0.1:50443_ x:collection1
oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1635329 T12017 n:127.0.0.1:50443_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=22, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=56.4921875,
floorSegmentMB=1.5576171875, forceMergeDeletesPctAllowed=5.838031642506935,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1635329 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@64ed4d9c
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@26dbdf58),segFN=segments_1,generation=1}
[junit4] 2> 1635329 T12017 n:127.0.0.1:50443_ x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1635329 T12017 n:127.0.0.1:50443_ x:collection1
oass.SolrIndexSearcher.<init> Opening Searcher@41fc78c3[collection1] main
[junit4] 2> 1635329 T12017 n:127.0.0.1:50443_ x:collection1
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/collection1
[junit4] 2> 1635330 T12017 n:127.0.0.1:50443_ x:collection1
oascc.ZkStateReader.readConfigName path=/collections/collection1
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1635330 T12017 n:127.0.0.1:50443_ x:collection1
oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for
the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1635330 T12017 n:127.0.0.1:50443_ x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1635330 T12017 n:127.0.0.1:50443_ x:collection1
oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 1635330 T12017 n:127.0.0.1:50443_ x:collection1
oasr.ManagedResourceStorage.load Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1635331 T12017 n:127.0.0.1:50443_ x:collection1
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found
for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1635331 T12017 n:127.0.0.1:50443_ x:collection1
oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1635331 T12017 n:127.0.0.1:50443_ x:collection1
oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 1635331 T12017 n:127.0.0.1:50443_ x:collection1
oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1635331 T12018 n:127.0.0.1:50443_ x:collection1
oasc.SolrCore.registerSearcher [collection1] Registered new searcher
Searcher@41fc78c3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1635331 T12017 n:127.0.0.1:50443_ x:collection1
oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
[junit4] 2> 1635332 T12017 n:127.0.0.1:50443_ x:collection1
oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1635333 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.register Register replica - core:collection1
address:http://127.0.0.1:50443 collection:collection1 shard:shard1
[junit4] 2> 1635334 T11959 n:127.0.0.1:50443_ oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1635334 T11959 n:127.0.0.1:50443_ oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 1635341 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leader_elect/shard1/election
[junit4] 2> 1635351 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running the
leader process for shard shard1
[junit4] 2> 1635353 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough
replicas found to continue.
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new
leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2231 name=collection1
org.apache.solr.core.SolrCore@dbb9f91 url=http://127.0.0.1:50443/collection1
node=127.0.0.1:50443_ C2231_STATE=coll:collection1 core:collection1
props:{core=collection1, base_url=http://127.0.0.1:50443,
node_name=127.0.0.1:50443_, state=down}
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 C2231 oasc.SyncStrategy.sync Sync replicas to
http://127.0.0.1:50443/collection1/
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 C2231 oasc.SyncStrategy.syncReplicas Sync Success - now sync
replicas to me
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 C2231 oasc.SyncStrategy.syncToMe
http://127.0.0.1:50443/collection1/ has no replicas
[junit4] 2> 1635353 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new
leader: http://127.0.0.1:50443/collection1/ shard1
[junit4] 2> 1635354 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oascc.SolrZkClient.makePath makePath:
/collections/collection1/leaders/shard1
[junit4] 2> 1635360 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1"} current state version: 4
[junit4] 2> 1635367 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1635368 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "base_url":"http://127.0.0.1:50443";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 4
[junit4] 2> 1635436 T11987 n:127.0.0.1:50430_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1635437 T11999 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1635437 T12016 n:127.0.0.1:50443_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1635466 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.register We are
http://127.0.0.1:50443/collection1/ and leader is
http://127.0.0.1:50443/collection1/
[junit4] 2> 1635466 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.register No LogReplay needed for
core=collection1 baseURL=http://127.0.0.1:50443
[junit4] 2> 1635466 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.checkRecovery I am the leader, no recovery
necessary
[junit4] 2> 1635466 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.publish publishing core=collection1
state=active collection=collection1
[junit4] 2> 1635466 T12021 n:127.0.0.1:50443_ c:collection1 s:shard1
x:collection1 oasc.ZkController.publish numShards not found on descriptor -
reading it from system property
[junit4] 2> 1635467 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1635468 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50443";,
[junit4] 2> "node_name":"127.0.0.1:50443_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 1635469 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50443";,
[junit4] 2> "node_name":"127.0.0.1:50443_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1635529 T11959 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1
[junit4] 2> 1635531 T11959 oasc.AbstractFullDistribZkTestBase.createJettys
create jetty 2 in directory
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001
[junit4] 2> 1635532 T11959 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 1635534 T11959 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@3096c080{/,null,AVAILABLE}
[junit4] 2> 1635534 T11959 oejs.AbstractConnector.doStart Started
ServerConnector@392a8c40{HTTP/1.1}{127.0.0.1:50476}
[junit4] 2> 1635535 T11959 oejs.Server.doStart Started @1646503ms
[junit4] 2> 1635535 T11959 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties:
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\tempDir-001/jetty2, solrconfig=solrconfig.xml,
hostContext=/, hostPort=50475,
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores}
[junit4] 2> 1635535 T11959 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1635536 T11959 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\'
[junit4] 2> 1635536 T11999 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1635536 T12016 n:127.0.0.1:50443_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1635536 T11987 n:127.0.0.1:50430_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 1635552 T11959 oasc.SolrXmlConfig.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\solr.xml
[junit4] 2> 1635556 T11959 oasc.CorePropertiesLocator.<init>
Config-defined core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores
[junit4] 2> 1635556 T11959 oasc.CoreContainer.<init> New CoreContainer
752095150
[junit4] 2> 1635556 T11959 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\]
[junit4] 2> 1635557 T11959 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\lib
[junit4] 2> 1635557 T11959 oasc.SolrResourceLoader.addToClassLoader WARN
Can't find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\lib).
[junit4] 2> 1635565 T11959 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 1635568 T11959 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1635568 T11959 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1635568 T11959 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1635568 T11959 oasc.CoreContainer.load Node Name: 127.0.0.1
[junit4] 2> 1635569 T11959 oasc.ZkContainer.initZooKeeper Zookeeper
client=127.0.0.1:50413/solr
[junit4] 2> 1635569 T11959 oasc.ZkController.checkChrootPath zkHost
includes chroot
[junit4] 2> 1635569 T11959
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default
ZkCredentialsProvider
[junit4] 2> 1635570 T11959 oascc.ConnectionManager.waitForConnected
Waiting for client to connect to ZooKeeper
[junit4] 2> 1635571 T12036 oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@45481354
name:ZooKeeperConnection Watcher:127.0.0.1:50413 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1635572 T11959 oascc.ConnectionManager.waitForConnected Client
is connected to ZooKeeper
[junit4] 2> 1635572 T11959 oascc.SolrZkClient.createZkACLProvider Using
default ZkACLProvider
[junit4] 2> 1635575 T11959 n:127.0.0.1:50475_
oascc.ConnectionManager.waitForConnected Waiting for client to connect to
ZooKeeper
[junit4] 2> 1635576 T12039 n:127.0.0.1:50475_
oascc.ConnectionManager.process Watcher
org.apache.solr.common.cloud.ConnectionManager@4d04c238
name:ZooKeeperConnection Watcher:127.0.0.1:50413/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1635576 T11959 n:127.0.0.1:50475_
oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1635581 T11959 n:127.0.0.1:50475_
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state
from ZooKeeper...
[junit4] 2> 1636230 T11959 n:127.0.0.1:50475_
oasc.ZkController.createEphemeralLiveNode Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50475_
[junit4] 2> 1636231 T11959 n:127.0.0.1:50475_ oascc.SolrZkClient.makePath
makePath: /live_nodes/127.0.0.1:50475_
[junit4] 2> 1636234 T11959 n:127.0.0.1:50475_ oasc.Overseer.close Overseer
(id=null) closing
[junit4] 2> 1636235 T11959 n:127.0.0.1:50475_
oasc.CorePropertiesLocator.discover Looking for core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores
[junit4] 2> 1636237 T11959 n:127.0.0.1:50475_ oasc.CoreDescriptor.<init>
CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false,
schema=schema.xml, loadOnStartup=true,
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1, collection=collection1,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\, coreNodeName=,
dataDir=data\, shard=}
[junit4] 2> 1636237 T11959 n:127.0.0.1:50475_
oasc.CorePropertiesLocator.discoverUnder Found core collection1 in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\
[junit4] 2> 1636237 T11959 n:127.0.0.1:50475_
oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 1636238 T12040 n:127.0.0.1:50475_ c:collection1 x:collection1
oasc.ZkController.publish publishing core=collection1 state=down
collection=collection1
[junit4] 2> 1636238 T12040 n:127.0.0.1:50475_ c:collection1 x:collection1
oasc.ZkController.publish numShards not found on descriptor - reading it from
system property
[junit4] 2> 1636239 T11987 n:127.0.0.1:50430_
oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path
/overseer/queue state SyncConnected
[junit4] 2> 1636239 T12040 n:127.0.0.1:50475_
oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1636239 T11988 n:127.0.0.1:50430_
oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50475";,
[junit4] 2> "node_name":"127.0.0.1:50475_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 6
[junit4] 2> 1636240 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50475";,
[junit4] 2> "node_name":"127.0.0.1:50475_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1636240 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Collection already exists with numShards=1
[junit4] 2> 1636240 T11988 n:127.0.0.1:50430_
oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1636307 T11999 oascc.ZkStateReader$2.process A cluster state
change: WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1636307 T12016 n:127.0.0.1:50443_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 3)
[junit4] 2> 1636307 T12039 n:127.0.0.1:50475_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 3)
[junit4] 2> 1636307 T11987 n:127.0.0.1:50430_
oascc.ZkStateReader$2.process A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 3)
[junit4] 2> 1636885 T12040 n:127.0.0.1:50475_
oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for
collection1
[junit4] 2> 1636885 T12040 n:127.0.0.1:50475_
oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1636886 T12040 n:127.0.0.1:50475_
oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1636886 T12040 n:127.0.0.1:50475_
oascc.ZkStateReader.readConfigName Load collection config
from:/collections/collection1
[junit4] 2> 1636886 T12040 n:127.0.0.1:50475_
oascc.ZkStateReader.readConfigName path=/collections/collection1
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1636886 T12040 n:127.0.0.1:50475_
oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\'
[junit4] 2> 1636896 T12040 n:127.0.0.1:50475_ oasc.Config.<init> loaded
config solrconfig.xml with version 0
[junit4] 2> 1636900 T12040 n:127.0.0.1:50475_
oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
[junit4] 2> 1636903 T12040 n:127.0.0.1:50475_ oasc.SolrConfig.<init> Using
Lucene MatchVersion: 6.0.0
[junit4] 2> 1636914 T12040 n:127.0.0.1:50475_ oasc.SolrConfig.<init>
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1636915 T12040 n:127.0.0.1:50475_ oass.IndexSchema.readSchema
Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1636918 T12040 n:127.0.0.1:50475_ oass.IndexSchema.readSchema
[collection1] Schema name=test
[junit4] 2> 1636983 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider.init Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1636987 T12040 n:127.0.0.1:50475_ oass.IndexSchema.readSchema
default search field in schema is text
[junit4] 2> 1636988 T12040 n:127.0.0.1:50475_ oass.IndexSchema.readSchema
unique key field: id
[junit4] 2> 1636995 T12040 n:127.0.0.1:50475_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1636997 T12040 n:127.0.0.1:50475_
oass.FileExchangeRateProvider.reload Reloading exchange rates from file
currency.xml
[junit4] 2> 1636999 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1636999 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1637000 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1637000 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 1637000 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key
IMPORTANT NOTE
[junit4] 2> 1637000 T12040 n:127.0.0.1:50475_
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key,
got STRING
[junit4] 2> 1637000 T12040 n:127.0.0.1:50475_ oasc.CoreContainer.create
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 1637001 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1637001 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\], dataDir=[null]
[junit4] 2> 1637001 T12040 n:127.0.0.1:50475_ x:collection1
oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to
JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6b68dff1
[junit4] 2> 1637002 T12040 n:127.0.0.1:50475_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\data\
[junit4] 2> 1637002 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.getNewIndexDir New index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\data\index/
[junit4] 2> 1637002 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.initIndex WARN [collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\data\index' doesn't exist.
Creating new index...
[junit4] 2> 1637002 T12040 n:127.0.0.1:50475_ x:collection1
oasc.CachingDirectoryFactory.get return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.LeaderInitiatedRecoveryOnCommitTest
C24CF0BC50F6DDA3-001\shard-2-001\cores\collection1\data\index
[junit4] 2> 1637003 T12040 n:127.0.0.1:50475_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=27, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=79.8349609375,
floorSegmentMB=1.30859375, forceMergeDeletesPctAllowed=6.492591399084552,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1637003 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3b764c86
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c9fe201),segFN=segments_1,generation=1}
[junit4] 2> 1637003 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1637006 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 1637007 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 1637010 T12040 n:127.0.0.1:50475_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1637011 T12040 n:127.0.0.1:50475_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1637012 T12040 n:127.0.0.1:50475_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1637012 T12040 n:127.0.0.1:50475_ x:collection1
oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1637015 T12040 n:127.0.0.1:50475_ x:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1637016 T12040 n:127.0.0.1:50475_ x:collection1
oasc.SolrCore.initStatsCache Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1637016 T12040 n:127.0.0.1:50475_ x:collection1
oasu.UpdateHandler.<init> Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1637017 T12040 n:127.0.0.1:50475_ x:collection1
oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10
[junit4] 2> 1637017 T12040 n:127.0.0.1:50475_ x:collection1
oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1637017 T12040 n:127.0.0.1:50475_ x:collection1
oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1637018 T12040 n:127.0.0.1:50475_ x:collection1
oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=22, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=56.4921875,
floorSegmentMB=1.5576171875, forceMergeDeletesPct
[...truncated too long message...]
at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
[junit4] 2> at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
[junit4] 2> at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 37) Thread[id=12052,
name=qtp1900859510-12052-selector-ServerConnectorManager@1f38ea/0,
state=RUNNABLE, group=TGRP-LeaderInitiatedRecoveryOnCommitTest]
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] 2> at
sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:596)
[junit4] 2> at
org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:545)
[junit4] 2> at
org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 38) Thread[id=12097, name=Thread-3981, state=WAITING,
group=TGRP-LeaderInitiatedRecoveryOnCommitTest]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:911)
[junit4] 2> NOTE: test params are:
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=4, maxDocsPerChunk=4, blockSize=651),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=4, blockSize=651)),
sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ca,
timezone=Atlantic/St_Helena
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_45
(64-bit)/cpus=3,threads=75,free=310362368,total=480247808
[junit4] 2> NOTE: All tests run in this JVM: [HttpPartitionTest,
SharedFSAutoReplicaFailoverTest, TestCloudInspectUtil, TestRandomFaceting,
TestCoreDiscovery, TestAnalyzeInfixSuggestions, TestMiniSolrCloudClusterSSL,
RemoteQueryErrorTest, TestCloudManagedSchema, ExitableDirectoryReaderTest,
ExternalCollectionsTest, TestFoldingMultitermQuery, BufferStoreTest,
CursorPagingTest, TestRequestStatusCollectionAPI, MBeansHandlerTest,
TestCopyFieldCollectionResource, QueryEqualityTest, HdfsDirectoryTest,
DistributedIntervalFacetingTest, SpatialHeatmapFacetsTest,
HdfsWriteToMultipleCollectionsTest, AsyncMigrateRouteKeyTest,
RAMDirectoryFactoryTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
CurrencyFieldXmlFileTest, TestLMJelinekMercerSimilarityFactory,
TestSolrConfigHandlerCloud, TestCollapseQParserPlugin, TestCustomSort,
TestSerializedLuceneMatchVersion, WordBreakSolrSpellCheckerTest,
TestRemoteStreaming, CurrencyFieldOpenExchangeTest, ResponseHeaderTest,
PolyFieldTest, TestJsonFacets, TestSolrConfigHandlerConcurrent,
TestReloadAndDeleteDocs, SimplePostToolTest, TestObjectReleaseTracker,
TestExactStatsCache, LeaderElectionIntegrationTest, TestMergePolicyConfig,
DeleteInactiveReplicaTest, TermVectorComponentDistributedTest,
TestNonDefinedSimilarityFactory, TestDFRSimilarityFactory,
TestDistributedGrouping, TestBadConfig, TestCursorMarkWithoutUniqueKey,
StandardRequestHandlerTest, FileUtilsTest, PrimitiveFieldTypeTest,
BlockCacheTest, TestSimpleQParserPlugin, BasicZkTest, IndexSchemaTest,
BasicDistributedZk2Test, TestMiniSolrCloudCluster,
CloudExitableDirectoryReaderTest, SpellingQueryConverterTest,
HdfsRecoveryZkTest, TestSolrQueryParserDefaultOperatorResource,
TestRandomMergePolicy, DirectSolrSpellCheckerTest, TestRecovery,
TermVectorComponentTest, TestFastOutputStream, TestFiltering,
TestDistributedMissingSort, ZkNodePropsTest, SchemaVersionSpecificBehaviorTest,
BadIndexSchemaTest, EchoParamsTest, TestJettySolrRunner,
ShardRoutingCustomTest, SuggestComponentTest, DeleteShardTest,
OverseerStatusTest, SuggesterTSTTest, TermsComponentTest, TestInitQParser,
FileBasedSpellCheckerTest, TestReversedWildcardFilterFactory,
DistributedDebugComponentTest, TestSimpleTrackingShardHandler,
TriLevelCompositeIdRoutingTest, TestUtils, SignatureUpdateProcessorFactoryTest,
TestRawResponseWriter, SolrRequestParserTest, SegmentsInfoRequestHandlerTest,
TestSolrJ, CSVRequestHandlerTest, TestTrie, TestCloudManagedSchemaConcurrent,
TestDefaultStatsCache, PluginInfoTest, UpdateRequestProcessorFactoryTest,
SearchHandlerTest, PreAnalyzedUpdateProcessorTest, CursorMarkTest,
AutoCommitTest, DirectUpdateHandlerOptimizeTest, TestInitParams,
BlockDirectoryTest, TestManagedStopFilterFactory, TestJsonRequest,
DateFieldTest, CloudMLTQParserTest, TestSolrQueryParser, RankQueryTest,
BinaryUpdateRequestHandlerTest, TestDocSet, TestSchemaSimilarityResource,
DocumentBuilderTest, OpenCloseCoreStressTest, OverseerTest,
TestReplicationHandler, TestZkChroot, TestFaceting, TestHashPartitioner,
TestJoin, TestReload, HardAutoCommitTest, TestRangeQuery, SimpleFacetsTest,
StatsComponentTest, QueryElevationComponentTest, ConvertedLegacyTest,
BasicFunctionalityTest, DirectUpdateHandlerTest,
OverseerCollectionProcessorTest, SoftAutoCommitTest,
DistributedQueryElevationComponentTest, TestExtendedDismaxParser,
TestStressLucene, SpatialFilterTest, NoCacheHeaderTest, TestPseudoReturnFields,
TestAtomicUpdateErrorCases, DefaultValueUpdateProcessorTest,
StatelessScriptUpdateProcessorFactoryTest, DebugComponentTest,
IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, TestQueryUtils,
TestOmitPositions, RequestHandlersTest, MoreLikeThisHandlerTest,
TestArbitraryIndexDir, RegexBoostProcessorTest, TestCollationField,
ReturnFieldsTest, QueryParsingTest, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, TestComponentsName, HighlighterConfigTest,
TestQuerySenderListener, AlternateDirectoryTest, TestQuerySenderNoQuery,
SolrIndexConfigTest, TestSolrDeletionPolicy2, TestSearchPerf,
TestElisionMultitermQuery, OutputWriterTest, ExternalFileFieldSortTest,
TestSolrCoreProperties, NotRequiredUniqueKeyTest, TestLuceneMatchVersion,
TestPerFieldSimilarity, TestIBSimilarityFactory, TestDefaultSimilarityFactory,
ResourceLoaderTest, TestFastLRUCache, TestSystemIdResolver,
TestDocumentBuilder, DistributedMLTComponentTest,
CollectionsAPIAsyncDistributedZkTest, DeleteReplicaTest,
DistribDocExpirationUpdateProcessorTest, LeaderInitiatedRecoveryOnCommitTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=LeaderInitiatedRecoveryOnCommitTest -Dtests.seed=C24CF0BC50F6DDA3
-Dtests.slow=true -Dtests.locale=ca -Dtests.timezone=Atlantic/St_Helena
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | LeaderInitiatedRecoveryOnCommitTest (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([C24CF0BC50F6DDA3]:0)
[junit4] Completed [484/484] on J1 in 7279.28s, 1 test, 2 errors <<<
FAILURES!
[...truncated 11 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:526: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: 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:229:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:512:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1415:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:973:
There were test failures: 484 suites, 1944 tests, 1 suite-level error, 1
error, 63 ignored (34 assumptions)
Total time: 167 minutes 29 seconds
Build step 'Invoke Ant' marked build as failure
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]
