Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/2386/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ZkControllerTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=10795,
name=OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000,
state=TIMED_WAITING, group=Overseer state updater.] at
java.lang.Object.wait(Native Method) at
org.apache.solr.cloud.DistributedQueue$LatchWatcher.await(DistributedQueue.java:276)
at
org.apache.solr.cloud.DistributedQueue.getChildren(DistributedQueue.java:320)
at org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:594)
at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:572)
at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:190)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=10795,
name=OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000,
state=TIMED_WAITING, group=Overseer state updater.]
at java.lang.Object.wait(Native Method)
at
org.apache.solr.cloud.DistributedQueue$LatchWatcher.await(DistributedQueue.java:276)
at
org.apache.solr.cloud.DistributedQueue.getChildren(DistributedQueue.java:320)
at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:594)
at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:572)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:190)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([CB8C4132A62525]:0)
Build Log:
[...truncated 10220 lines...]
[junit4] Suite: org.apache.solr.cloud.ZkControllerTest
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.ZkControllerTest
CB8C4132A62525-001/init-core-data-001
[junit4] 2> 2116074 INFO
(SUITE-ZkControllerTest-seed#[CB8C4132A62525]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 2116077 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testReadConfigName
[junit4] 2> 2116077 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2116079 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2116079 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2116180 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.ZkTestServer start zk server on port:49876
[junit4] 2> 2116180 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2116182 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2116196 INFO (zkCallback-1302-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@e4970ce name:ZooKeeperConnection
Watcher:127.0.0.1:49876 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2116197 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2116197 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2116200 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2116202 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2116205 INFO (zkCallback-1303-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2e210615
name:ZooKeeperConnection Watcher:127.0.0.1:49876 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2116206 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2116206 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2116206 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2116213 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2116217 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2116218 INFO (zkCallback-1304-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@63ec41e8
name:ZooKeeperConnection Watcher:127.0.0.1:49876/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2116218 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2116219 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2116219 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/firstConfig
[junit4] 2> 2116225 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 2116235 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525]) [ ]
o.a.s.c.CoreContainer New CoreContainer 157978452
[junit4] 2> 2116239 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2116241 INFO
(zkCallback-1305-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@71f79007
name:ZooKeeperConnection Watcher:127.0.0.1:49876/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2116241 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2116244 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2116252 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 2116258 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 2116265 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 2116272 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 2116283 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2116288 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2116293 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2116297 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2116298 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2116302 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.u.UpdateShardHandler Creating
UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 2116311 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2116316 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 2116320 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2116323 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:8983_solr
[junit4] 2> 2116323 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 2116328 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417128144899-127.0.0.1:8983_solr-n_0000000000) starting
[junit4] 2> 2116334 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 2116355 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2116357 INFO
(OverseerCollectionProcessor-93946417128144899-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerCollectionProcessor Process
current queue of collection creations
[junit4] 2> 2116358 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 2116361 INFO
(OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 2116378 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader Load collection config
from:/collections/collection1
[junit4] 2> 2116381 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader
path=/collections/collection1 configName=firstConfig specified config exists in
ZooKeeper
[junit4] 2> 2116382 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417128144899-127.0.0.1:8983_solr-n_0000000000) closing
[junit4] 2> 2116385 WARN
(OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader Error reading collections
nodes
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn.submitRequest(ClientCnxn.java:1342)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1040)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:319)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:316)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:316)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.getIndividualColls(ZkStateReader.java:513)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.constructState(ZkStateReader.java:468)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:540)
[junit4] 2> at
org.apache.solr.common.cloud.ZkStateReader.updateClusterState(ZkStateReader.java:269)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:152)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2116404 WARN
(zkCallback-1305-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK
[junit4] 2> 2116405 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=157978452
[junit4] 2> 2116407 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49876
49876
[junit4] 2> 2116417 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:49876 49876
[junit4] 2> 2117751 INFO
(TEST-ZkControllerTest.testReadConfigName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Ending testReadConfigName
[junit4] IGNOR/A 0.03s J1 | ZkControllerTest.testPublishAndWaitForDownStates
[junit4] > Assumption #1: 'awaitsfix' test group is disabled
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-6665))
[junit4] 2> 2117783 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Starting
testEnsureReplicaInLeaderInitiatedRecovery
[junit4] 2> 2117785 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2117786 INFO (Thread-4142) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2117786 INFO (Thread-4142) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2117886 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer start zk server on port:49881
[junit4] 2> 2117886 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2117888 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2117897 INFO
(zkCallback-1307-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@40ac3d28
name:ZooKeeperConnection Watcher:127.0.0.1:49881 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2117898 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2117898 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2117901 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2117903 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2117905 INFO
(zkCallback-1308-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2b85d659
name:ZooKeeperConnection Watcher:127.0.0.1:49881 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2117905 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2117905 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2117906 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2117913 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.CoreContainer New CoreContainer 1198143763
[junit4] 2> 2117915 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2117917 INFO
(zkCallback-1309-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6de80b0e
name:ZooKeeperConnection Watcher:127.0.0.1:49881/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2117917 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2117920 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2117925 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 2117932 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 2117937 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 2117945 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 2117952 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2117956 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2117960 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2117965 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2117969 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2117969 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2117975 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.u.UpdateShardHandler Creating
UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 2117976 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2117982 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 2117986 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2117989 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:8983_solr
[junit4] 2> 2117989 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 2117995 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417240080386-127.0.0.1:8983_solr-n_0000000000) starting
[junit4] 2> 2118000 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 2118021 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2118022 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 2118023 INFO
(OverseerCollectionProcessor-93946417240080386-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerCollectionProcessor Process
current queue of collection creations
[junit4] 2> 2118026 INFO
(OverseerStateUpdate-93946417240080386-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 2118038 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417240080386-127.0.0.1:8983_solr-n_0000000000) closing
[junit4] 2> 2118039 INFO
(OverseerStateUpdate-93946417240080386-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:8983_solr
[junit4] 2> 2118045 WARN
(zkCallback-1309-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK
[junit4] 2> 2118046 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=1198143763
[junit4] 2> 2118049 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49881
49881
[junit4] 2> 2118061 INFO (Thread-4142) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:49881 49881
[junit4] 2> 2119545 ERROR (OverseerExitThread) [n:127.0.0.1:8983_solr ]
o.a.s.c.Overseer could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:298)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:85)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:259)
[junit4] 2> 2119638 INFO
(TEST-ZkControllerTest.testEnsureReplicaInLeaderInitiatedRecovery-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Ending
testEnsureReplicaInLeaderInitiatedRecovery
[junit4] 2> 2119644 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Starting testGetHostName
[junit4] 2> 2119646 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2119649 INFO (Thread-4143) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2119650 INFO (Thread-4143) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2119750 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer start zk server on port:49885
[junit4] 2> 2119751 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2119753 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2119765 INFO
(zkCallback-1311-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@965502e name:ZooKeeperConnection
Watcher:127.0.0.1:49885 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 2119765 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2119766 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2119769 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2119771 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2119775 INFO
(zkCallback-1312-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@457098b7
name:ZooKeeperConnection Watcher:127.0.0.1:49885 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2119776 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2119776 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2119776 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2119785 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.CoreContainer New CoreContainer 337270524
[junit4] 2> 2119786 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2119788 INFO
(zkCallback-1313-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@590ca3f3
name:ZooKeeperConnection Watcher:127.0.0.1:49885/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2119789 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2119791 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2119798 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 2119805 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 2119813 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 2119820 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 2119827 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2119831 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2119836 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2119840 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2119845 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2119847 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:8983_solr
[junit4] 2> 2119851 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.u.UpdateShardHandler Creating
UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 2119853 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2119858 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 2119863 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2119868 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:8983_solr
[junit4] 2> 2119868 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 2119874 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417362108418-127.0.0.1:8983_solr-n_0000000000) starting
[junit4] 2> 2119881 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 2119903 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2119906 INFO
(OverseerCollectionProcessor-93946417362108418-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.OverseerCollectionProcessor Process
current queue of collection creations
[junit4] 2> 2119907 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 2119907 INFO
(OverseerStateUpdate-93946417362108418-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 2119918 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer
(id=93946417362108418-127.0.0.1:8983_solr-n_0000000000) closing
[junit4] 2> 2119919 INFO
(OverseerStateUpdate-93946417362108418-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:8983_solr
[junit4] 2> 2119929 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0)
[n:127.0.0.1:8983_solr ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x14dc3c4d2ca0002, 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> 2121427 ERROR (OverseerExitThread) [n:127.0.0.1:8983_solr ]
o.a.s.c.Overseer could not read the data
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:298)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:85)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:259)
[junit4] 2> 2121430 WARN
(zkCallback-1313-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK
[junit4] 2> 2121430 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.CoreContainer Shutting down CoreContainer
instance=337270524
[junit4] 2> 2121431 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49885
49885
[junit4] 2> 2121440 INFO (Thread-4143) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:49885 49885
[junit4] 2> 2123001 INFO
(TEST-ZkControllerTest.testGetHostName-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Ending testGetHostName
[junit4] 2> 2123006 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Starting
testNodeNameUrlConversion
[junit4] 2> 2123008 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2123009 INFO (Thread-4144) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2123009 INFO (Thread-4144) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2123110 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer start zk server on port:49889
[junit4] 2> 2123110 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2123112 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2123126 INFO
(zkCallback-1315-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@25b27119
name:ZooKeeperConnection Watcher:127.0.0.1:49889 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2123126 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2123127 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2123129 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2123133 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2123134 INFO
(zkCallback-1316-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2646be0f
name:ZooKeeperConnection Watcher:127.0.0.1:49889 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2123135 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2123135 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2123135 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2123141 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default
ZkCredentialsProvider
[junit4] 2> 2123143 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2123145 INFO
(zkCallback-1317-thread-1-processing-n:127.0.0.1:8983_solr)
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1e9bd8b2
name:ZooKeeperConnection Watcher:127.0.0.1:49889/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2123145 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2123146 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2123167 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49889
49889
[junit4] 2> 2123196 INFO (Thread-4144) [n:127.0.0.1:8983_solr ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:49889 49889
[junit4] 2> 2124441 INFO
(TEST-ZkControllerTest.testNodeNameUrlConversion-seed#[CB8C4132A62525])
[n:127.0.0.1:8983_solr ] o.a.s.SolrTestCaseJ4 ###Ending
testNodeNameUrlConversion
[junit4] 2> 2124443 INFO
(SUITE-ZkControllerTest-seed#[CB8C4132A62525]-worker) [n:127.0.0.1:8983_solr
] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> Jun 05, 2015 12:49:30 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Jun 05, 2015 12:49:50 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.cloud.ZkControllerTest:
[junit4] 2> 1) Thread[id=10795,
name=OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000,
state=TIMED_WAITING, group=Overseer state updater.]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue$LatchWatcher.await(DistributedQueue.java:276)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.getChildren(DistributedQueue.java:320)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:594)
[junit4] 2> at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:572)
[junit4] 2> at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:190)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Jun 05, 2015 12:49:50 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=10795,
name=OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000,
state=TIMED_WAITING, group=Overseer state updater.]
[junit4] 2> 2144687 INFO
(OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000)
[n:127.0.0.1:8983_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:8983_solr
[junit4] 2> Jun 05, 2015 12:49:50 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=DefaultSimilarity, locale=de_CH,
timezone=America/Port-au-Prince
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45
(64-bit)/cpus=3,threads=1,free=127768976,total=421527552
[junit4] 2> NOTE: All tests run in this JVM: [HighlighterMaxOffsetTest,
TestBulkSchemaAPI, XsltUpdateRequestHandlerTest, TestMaxScoreQueryParser,
TestZkChroot, CollectionsAPIAsyncDistributedZkTest, ChangedSchemaMergeTest,
BasicDistributedZk2Test, TestDocSet, TestJoin, TestSchemaNameResource,
TestCollectionAPI, SpellingQueryConverterTest, DistribJoinFromCollectionTest,
DirectUpdateHandlerOptimizeTest, SolrTestCaseJ4Test,
HdfsBasicDistributedZk2Test, DateMathParserTest, TestRemoteStreaming,
ParsingFieldUpdateProcessorsTest, TestManagedResourceStorage, TestRestoreCore,
TestUtils, TestReplicationHandlerBackup, TestJsonRequest,
VMParamsZkACLAndCredentialsProvidersTest, SpellCheckCollatorTest,
LoggingHandlerTest, TestClusterStateMutator, HdfsUnloadDistributedZkTest,
PluginInfoTest, TestTrie, TestSearchPerf, TestManagedSynonymFilterFactory,
TestDefaultStatsCache, AnalyticsMergeStrategyTest, SolrCmdDistributorTest,
BasicFunctionalityTest, TestCodecSupport, ConnectionManagerTest,
OpenExchangeRatesOrgProviderTest, ResourceLoaderTest, FacetPivotSmallTest,
TestSolrQueryParserResource, TestLMDirichletSimilarityFactory,
ConvertedLegacyTest, TestRealTimeGet, TestMiniSolrCloudClusterSSL,
DocExpirationUpdateProcessorFactoryTest, TestReplicaProperties,
TestConfigOverlay, BlockDirectoryTest, MinimalSchemaTest,
OverseerCollectionProcessorTest, FastVectorHighlighterTest, DateFieldTest,
TestCustomSort, BadIndexSchemaTest, TestFastOutputStream, TestBadConfig,
TestSolrJ, OpenCloseCoreStressTest, TestValueSourceCache, HdfsLockFactoryTest,
NotRequiredUniqueKeyTest, FieldMutatingUpdateProcessorTest,
HdfsWriteToMultipleCollectionsTest, StatelessScriptUpdateProcessorFactoryTest,
CdcrVersionReplicationTest, DistributedTermsComponentTest,
IndexBasedSpellCheckerTest, EnumFieldTest, TestManagedSchemaFieldResource,
CloudMLTQParserTest, CurrencyFieldOpenExchangeTest, TestFieldResource,
TestNoOpRegenerator, TestSolr4Spatial, TestManagedSchema,
TestPHPSerializedResponseWriter, SuggestComponentTest, AliasIntegrationTest,
BasicZkTest, TestOverriddenPrefixQueryForCustomFieldType, DistanceUnitsTest,
TestDistributedGrouping, HighlighterConfigTest, RAMDirectoryFactoryTest,
CollectionReloadTest, TestStressUserVersions, SolrIndexConfigTest,
HdfsNNFailoverTest, ShardSplitTest, CurrencyFieldXmlFileTest,
DistribDocExpirationUpdateProcessorTest, StatsComponentTest, TestFastWriter,
TestRTGBase, SignatureUpdateProcessorFactoryTest, TestDistribDocBasedVersion,
DistributedDebugComponentTest, DistribCursorPagingTest, MultiThreadedOCPTest,
TestBlendedInfixSuggestions, ReturnFieldsTest, TestQuerySenderListener,
TestMiniSolrCloudCluster, TestFieldCollectionResource, TestSimpleQParserPlugin,
DirectSolrSpellCheckerTest, TestFreeTextSuggestions, TestSortingResponseWriter,
SharedFSAutoReplicaFailoverUtilsTest, TestLMJelinekMercerSimilarityFactory,
TestSuggestSpellingConverter, DistributedFacetPivotSmallAdvancedTest,
AnalyticsQueryTest, TestClassNameShortening, TestImplicitCoreProperties,
TestRecovery, TestSystemIdResolver, TestLeaderElectionZkExpiry,
BasicDistributedZkTest, ChaosMonkeySafeLeaderTest,
CollectionsAPIDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest,
ShardRoutingTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest,
ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest,
TestRandomDVFaceting, ShardRoutingCustomTest, AutoCommitTest, TestFaceting,
DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest,
ZkControllerTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkControllerTest
-Dtests.seed=CB8C4132A62525 -Dtests.slow=true -Dtests.locale=de_CH
-Dtests.timezone=America/Port-au-Prince -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | ZkControllerTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.ZkControllerTest:
[junit4] > 1) Thread[id=10795,
name=OverseerStateUpdate-93946417128144899-127.0.0.1:8983_solr-n_0000000000,
state=TIMED_WAITING, group=Overseer state updater.]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at
org.apache.solr.cloud.DistributedQueue$LatchWatcher.await(DistributedQueue.java:276)
[junit4] > at
org.apache.solr.cloud.DistributedQueue.getChildren(DistributedQueue.java:320)
[junit4] > at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:594)
[junit4] > at
org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:572)
[junit4] > at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:190)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([CB8C4132A62525]:0)
[junit4] Completed [272/505] on J1 in 28.67s, 5 tests, 1 error, 1 skipped
<<< FAILURES!
[...truncated 706 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:526: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:474: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:230: The
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:512:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1418:
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:973:
There were test failures: 505 suites, 1989 tests, 1 suite-level error, 63
ignored (24 assumptions)
Total time: 75 minutes 55 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]
