You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2015/09/25 04:27:56 UTC
[JENKINS] Lucene-Solr-Tests-trunk-Java8 - Build # 409 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java8/409/
1 tests failed.
REGRESSION: org.apache.solr.cloud.OverseerTest.testExternalClusterStateChangeBehavior
Error Message:
Illegal state, was: down expected:active clusterState:live nodes:[]collections:{c1=DocCollection(c1)={ "shards":{"shard1":{ "parent":null, "range":null, "state":"active", "replicas":{"core_node1":{ "base_url":"http://127.0.0.1/solr", "node_name":"node1", "core":"core1", "roles":"", "state":"down"}}}}, "router":{"name":"implicit"}}, test=LazyCollectionRef(test)}
Stack Trace:
java.lang.AssertionError: Illegal state, was: down expected:active clusterState:live nodes:[]collections:{c1=DocCollection(c1)={
"shards":{"shard1":{
"parent":null,
"range":null,
"state":"active",
"replicas":{"core_node1":{
"base_url":"http://127.0.0.1/solr",
"node_name":"node1",
"core":"core1",
"roles":"",
"state":"down"}}}},
"router":{"name":"implicit"}}, test=LazyCollectionRef(test)}
at __randomizedtesting.SeedInfo.seed([8E9388A7A3091CD9:E68D8B4B41994697]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.OverseerTest.verifyStatus(OverseerTest.java:601)
at org.apache.solr.cloud.OverseerTest.testExternalClusterStateChangeBehavior(OverseerTest.java:1261)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1665)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:864)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:900)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:914)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:873)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:775)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:809)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:820)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10158 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_8E9388A7A3091CD9-001/init-core-data-001
[junit4] 2> 1027483 INFO (SUITE-OverseerTest-seed#[8E9388A7A3091CD9]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1027483 INFO (SUITE-OverseerTest-seed#[8E9388A7A3091CD9]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1027483 INFO (SUITE-OverseerTest-seed#[8E9388A7A3091CD9]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1027485 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testShardAssignmentBigger
[junit4] 2> 1027485 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1027485 INFO (Thread-3329) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1027485 INFO (Thread-3329) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1027586 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.ZkTestServer start zk server on port:41551
[junit4] 2> 1027586 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027587 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027589 INFO (zkCallback-906-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f6122b2 name:ZooKeeperConnection Watcher:127.0.0.1:41551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027589 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027590 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027591 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027591 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027592 INFO (zkCallback-907-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@281f0f5a name:ZooKeeperConnection Watcher:127.0.0.1:41551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027592 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027592 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027592 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1027595 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027601 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027601 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2f0c516b name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027601 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027601 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027602 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1027603 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1027604 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1027605 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1027606 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1027607 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027608 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027609 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@52ec2569 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027609 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027609 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027609 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 1027611 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1027612 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1027613 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1027614 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94578089079668739-127.0.0.1:41551_solr-n_0000000000
[junit4] 2> 1027614 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41551_solr
[junit4] 2> 1027614 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1027615 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.Overseer Overseer (id=94578089079668739-127.0.0.1:41551_solr-n_0000000000) starting
[junit4] 2> 1027616 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1027618 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1027619 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1027624 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1027626 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1027628 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1027630 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1027631 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027631 INFO (OverseerCollectionConfigSetProcessor-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 1027632 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1027632 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027634 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027634 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027635 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d826cd1 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027635 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027636 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027637 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027639 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node0
[junit4] 2> 1027640 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 0)
[junit4] 2> 1027640 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 0)
[junit4] 2> 1027640 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 0)
[junit4] 2> 1027641 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027641 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027642 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c3821c7 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027642 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027642 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027644 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027645 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node1
[junit4] 2> 1027646 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1027646 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1027646 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1027646 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1027647 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027648 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027648 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@151aa5e0 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027649 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027649 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027650 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027652 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node2
[junit4] 2> 1027652 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1027652 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1027653 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1027653 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1027653 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1027653 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027654 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027655 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c42a925 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027655 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027655 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027656 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027658 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node3
[junit4] 2> 1027659 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027659 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027659 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027659 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027659 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027659 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1027660 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027661 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027661 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3db5ffde name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027661 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027662 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027663 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027664 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node4
[junit4] 2> 1027665 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027665 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027665 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027665 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027666 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027666 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027666 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 4)
[junit4] 2> 1027666 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027667 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027668 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@792b3ce0 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027668 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027668 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027670 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027671 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node5
[junit4] 2> 1027672 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027672 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027673 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 5)
[junit4] 2> 1027673 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027673 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027677 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@46c6bc67 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027677 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027678 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027679 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027680 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node6
[junit4] 2> 1027681 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027682 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027681 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027682 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 6)
[junit4] 2> 1027682 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027683 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027684 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@616376c6 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027684 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027684 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027685 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027687 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node7
[junit4] 2> 1027688 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027688 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027689 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 7)
[junit4] 2> 1027689 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027690 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027691 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2c609f40 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027691 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027691 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027693 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027694 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node8
[junit4] 2> 1027695 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027696 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027696 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027696 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027695 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 8)
[junit4] 2> 1027697 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027697 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027698 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2f0c6274 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027698 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027698 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027701 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027703 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node9
[junit4] 2> 1027704 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027704 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027705 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 9)
[junit4] 2> 1027705 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027706 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027707 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@580b0e6f name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027707 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027707 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027708 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027709 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node10
[junit4] 2> 1027710 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027710 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027710 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027710 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027710 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027710 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027711 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027712 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027712 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027713 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 10)
[junit4] 2> 1027714 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7f2a925 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027714 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027714 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027719 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027721 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node11
[junit4] 2> 1027722 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027722 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027723 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027723 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027724 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 11)
[junit4] 2> 1027724 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027728 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1892686b name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027728 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027728 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027729 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027730 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node12
[junit4] 2> 1027731 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027731 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027731 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027731 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027731 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027732 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027733 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 12)
[junit4] 2> 1027733 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027733 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027735 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1137ef88 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027735 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027735 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027736 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027738 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node13
[junit4] 2> 1027739 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027740 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027739 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027739 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027741 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027741 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 13)
[junit4] 2> 1027742 INFO (zkCallback-925-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@681838c5 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027742 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027743 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027744 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027745 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node14
[junit4] 2> 1027746 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-925-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027746 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027748 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027749 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 14)
[junit4] 2> 1027757 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027757 INFO (zkCallback-926-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5fa53951 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027757 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027757 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027759 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027760 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node15
[junit4] 2> 1027761 INFO (zkCallback-925-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027762 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027763 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1027762 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027761 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027763 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027763 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1027764 INFO (zkCallback-927-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6630505 name:ZooKeeperConnection Watcher:127.0.0.1:41551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1027764 INFO (zkCallback-926-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 15)
[junit4] 2> 1027764 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1027765 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1027766 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1027768 INFO (TEST-OverseerTest.testShardAssignmentBigger-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/node16
[junit4] 2> 1027769 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-925-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-926-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027770 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027770 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027769 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027770 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027770 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027770 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027771 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027771 INFO (zkCallback-927-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 16)
[junit4] 2> 1027776 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node3",
[junit4] 2> "core":"core3",
[junit4] 2> "core_node_name":"node3",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node3/solr/"} current state version: 0
[junit4] 2> 1027777 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node3",
[junit4] 2> "core":"core3",
[junit4] 2> "core_node_name":"node3",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node3/solr/"}
[junit4] 2> 1027777 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1
[junit4] 2> 1027777 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 1027778 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027778 INFO (zkCallback-916-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027778 INFO (zkCallback-919-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-912-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-924-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-921-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-908-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-925-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-923-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-926-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-920-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-917-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-914-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-927-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-911-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027779 INFO (zkCallback-915-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027780 INFO (zkCallback-922-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027780 INFO (zkCallback-918-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 17)
[junit4] 2> 1027783 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node2",
[junit4] 2> "core":"core2",
[junit4] 2> "core_node_name":"node2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node2/solr/"} current state version: 1
[junit4] 2> 1027783 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node2",
[junit4] 2> "core":"core2",
[junit4] 2> "core_node_name":"node2",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node2/solr/"}
[junit4] 2> 1027783 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=4
[junit4] 2> 1027783 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard3
[junit4] 2> 1027787 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node0",
[junit4] 2> "core":"core0",
[junit4] 2> "core_node_name":"node0",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node0/solr/"} current state version: 1
[junit4] 2> 1027787 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node0",
[junit4] 2> "core":"core0",
[junit4] 2> "core_node_name":"node0",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node0/solr/"}
[junit4] 2> 1027787 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=4
[junit4] 2> 1027787 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard4
[junit4] 2> 1027789 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "node_name":"node1",
[junit4] 2> "core":"core1",
[junit4] 2> "core_node_name":"node1",
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"4",
[junit4] 2> "base_url":"http://node1/solr/"} current state version: 1
[junit4] 2> 1027789 INFO (OverseerStateUpdate-94578089079668739-127.0.0.1:41551_solr-n_0000000000) [ ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"
[...truncated too long message...]
ion":"collection1",
[junit4] 2> "base_url":"http://node1/solr/",
[junit4] 2> "core":"core1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1091096 INFO (zkCallback-1020-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1091096 INFO (zkCallback-1019-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1091101 INFO (OverseerCollectionConfigSetProcessor-94578093194084354-127.0.0.1:60679_solr-n_0000000004) [ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 1091107 INFO (zkCallback-1019-thread-2) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1091107 INFO (zkCallback-1020-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1091109 INFO (TEST-OverseerTest.testOverseerStatsReset-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60679 60679
[junit4] 2> 1091198 INFO (OverseerStateUpdate-94578093194084354-127.0.0.1:60679_solr-n_0000000004) [ ] o.a.s.c.Overseer
[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.amILeader(Overseer.java:411)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:143)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1091199 INFO (OverseerStateUpdate-94578093194084354-127.0.0.1:60679_solr-n_0000000004) [ ] o.a.s.c.Overseer According to ZK I (id=94578093194084354-127.0.0.1:60679_solr-n_0000000004) am no longer a leader.
[junit4] 2> 1091199 INFO (OverseerStateUpdate-94578093194084354-127.0.0.1:60679_solr-n_0000000004) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60679_solr
[junit4] 2> 1091200 ERROR (OverseerExitThread) [ ] 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:304)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:87)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:265)
[junit4] 2> 1091328 INFO (Thread-3340) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60679 60679
[junit4] 2> 1091329 WARN (Thread-3340) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2> 2 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1091329 INFO (TEST-OverseerTest.testOverseerStatsReset-seed#[8E9388A7A3091CD9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatsReset
[junit4] 2> 1091329 INFO (TEST-OverseerTest.testOverseerStatsReset-seed#[8E9388A7A3091CD9]) [ ] o.a.s.c.Overseer Overseer (id=94578093194084354-127.0.0.1:60679_solr-n_0000000004) closing
[junit4] 2> 1094330 INFO (SUITE-OverseerTest-seed#[8E9388A7A3091CD9]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_8E9388A7A3091CD9-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=ClassicSimilarity, locale=in_ID, timezone=Asia/Gaza
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=4,threads=1,free=252829240,total=529006592
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrQueryParser, DocValuesMultiTest, TestConfigSetProperties, RecoveryAfterSoftCommitTest, TestManagedSynonymFilterFactory, TestLRUCache, SystemInfoHandlerTest, ConcurrentDeleteAndCreateCollectionTest, TestLRUStatsCache, TestManagedStopFilterFactory, TestManagedSchemaDynamicFieldResource, FieldAnalysisRequestHandlerTest, TestWriterPerf, OverriddenZkACLAndCredentialsProvidersTest, TestSolrDynamicMBean, TestManagedResourceStorage, HdfsDirectoryTest, TestReload, TestLeaderInitiatedRecoveryThread, HdfsWriteToMultipleCollectionsTest, TestPHPSerializedResponseWriter, TestSweetSpotSimilarityFactory, SecurityConfHandlerTest, TestPerFieldSimilarity, CdcrUpdateLogTest, TestIndexingPerformance, TestUniqueKeyFieldResource, HdfsDirectoryFactoryTest, TestReversedWildcardFilterFactory, NoCacheHeaderTest, TestCollectionAPI, TestIndexSearcher, HighlighterConfigTest, TestRecovery, AsyncCallRequestStatusResponseTest, TestAuthorizationFramework, CursorMarkTest, PrimitiveFieldTypeTest, TestSolrCloudWithKerberosAlt, TestCharFilters, BadComponentTest, MultiThreadedOCPTest, TestDefaultStatsCache, TestTrieFacet, BasicAuthIntegrationTest, TestSort, TestExpandComponent, TestCSVResponseWriter, SuggesterWFSTTest, StatelessScriptUpdateProcessorFactoryTest, CollectionsAPIAsyncDistributedZkTest, LukeRequestHandlerTest, CdcrVersionReplicationTest, UpdateParamsTest, BadIndexSchemaTest, HdfsThreadLeakTest, TestAddFieldRealTimeGet, LeaderElectionTest, SegmentsInfoRequestHandlerTest, TestRandomRequestDistribution, TestCoreDiscovery, AnalyticsMergeStrategyTest, TestExtendedDismaxParser, CloudMLTQParserTest, FullSolrCloudDistribCmdsTest, BigEndianAscendingWordDeserializerTest, SuggesterTest, AnalyticsQueryTest, TestCloudManagedSchema, TestSolrDeletionPolicy1, ScriptEngineTest, TestStressRecovery, TestFieldResource, CoreAdminHandlerTest, TestFieldTypeCollectionResource, TestSolr4Spatial2, UnloadDistributedZkTest, TestShardHandlerFactory, RegexBoostProcessorTest, SimpleFacetsTest, AddBlockUpdateTest, ResponseHeaderTest, TestCollapseQParserPlugin, TestElisionMultitermQuery, CollectionReloadTest, AssignTest, DistributedFacetPivotSmallTest, OverseerTaskQueueTest, AsyncMigrateRouteKeyTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest]
[junit4] Completed [278/546] on J2 in 66.86s, 12 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 839 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:775: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:719: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/common-build.xml:514: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:1432: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:987: There were test failures: 546 suites (8 ignored), 2145 tests, 1 failure, 47 ignored (35 assumptions) [seed: 8E9388A7A3091CD9]
Total time: 54 minutes 50 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-trunk-Java8 #408
Archived 4 artifacts
Archive block size is 32768
Received 0 blocks and 329550468 bytes
Compression is 0.0%
Took 54 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure