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 2016/07/03 20:11:24 UTC
[JENKINS] Lucene-Solr-Tests-6.x - Build # 310 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/310/
1 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay
Error Message:
expected:<2> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<1>
at __randomizedtesting.SeedInfo.seed([49CD1522A5B85E3A:3653A2A7CCDA73B0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:53)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
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:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
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 10764 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_49CD1522A5B85E3A-001/init-core-data-001
[junit4] 2> 129026 INFO (SUITE-ZkStateReaderTest-seed#[49CD1522A5B85E3A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 129027 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 129027 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 129028 INFO (Thread-694) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 129028 INFO (Thread-694) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 129128 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:43231
[junit4] 2> 129128 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129129 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129137 INFO (zkCallback-192-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@709f0c6f name:ZooKeeperConnection Watcher:127.0.0.1:43231 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129137 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129138 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129139 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129139 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129141 INFO (zkCallback-193-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5a52bd30 name:ZooKeeperConnection Watcher:127.0.0.1:43231 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 129144 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129144 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129146 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6778ebfe name:ZooKeeperConnection Watcher:127.0.0.1:43231/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129146 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129147 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129147 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 129148 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 129148 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 129149 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 129150 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 129150 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 129151 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 129151 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 129152 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 129152 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 129153 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 129153 INFO (zkCallback-194-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: [0])
[junit4] 2> 129162 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 129166 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 129166 INFO (zkCallback-194-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 129166 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 129167 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43231 43231
[junit4] 2> 129331 INFO (Thread-694) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43231 43231
[junit4] 2> 129333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=49CD1522A5B85E3A -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=bg -Dtests.timezone=WET -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.31s J0 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<2> but was:<1>
[junit4] > at __randomizedtesting.SeedInfo.seed([49CD1522A5B85E3A:3653A2A7CCDA73B0]:0)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:130)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:53)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 129336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 129336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 129337 INFO (Thread-695) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 129337 INFO (Thread-695) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 129437 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:36800
[junit4] 2> 129437 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129437 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129444 INFO (zkCallback-196-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@601f2102 name:ZooKeeperConnection Watcher:127.0.0.1:36800 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129444 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129444 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129445 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129445 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129447 INFO (zkCallback-197-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17ba600c name:ZooKeeperConnection Watcher:127.0.0.1:36800 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 129450 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129451 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129451 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2781f1f7 name:ZooKeeperConnection Watcher:127.0.0.1:36800/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129451 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129452 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129452 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 129453 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 129453 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 129454 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 129455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 129455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 129456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 129456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 129457 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 129457 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 129458 INFO (zkCallback-198-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: [0])
[junit4] 2> 129459 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 129459 INFO (zkCallback-198-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: [0])
[junit4] 2> 129462 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36800 36800
[junit4] 2> 129634 INFO (Thread-695) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36800 36800
[junit4] 2> 129635 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 129636 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 129637 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 129643 INFO (Thread-696) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 129643 INFO (Thread-696) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 129743 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:56311
[junit4] 2> 129743 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129751 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129761 INFO (zkCallback-200-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2340394a name:ZooKeeperConnection Watcher:127.0.0.1:56311 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129762 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129762 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129763 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129765 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129771 INFO (zkCallback-201-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3f5d8998 name:ZooKeeperConnection Watcher:127.0.0.1:56311 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129771 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129771 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129771 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 129774 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 129777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 129777 INFO (zkCallback-202-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f0fadbe name:ZooKeeperConnection Watcher:127.0.0.1:56311/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 129777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 129777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 129777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 129778 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 129778 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 129779 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 129779 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 129780 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 129780 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 129780 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 129781 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 129782 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 129782 INFO (zkCallback-202-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 129790 INFO (zkCallback-202-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 129791 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 129791 INFO (zkCallback-202-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 129792 INFO (zkCallback-202-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: [0])
[junit4] 2> 129792 INFO (zkCallback-202-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 129795 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56311 56311
[junit4] 2> 129899 INFO (Thread-696) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56311 56311
[junit4] 2> 129899 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 129901 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 129901 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 129901 INFO (Thread-697) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 129901 INFO (Thread-697) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 130001 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:37481
[junit4] 2> 130001 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130002 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130004 INFO (zkCallback-204-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1489dbc2 name:ZooKeeperConnection Watcher:127.0.0.1:37481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130004 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130005 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130006 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130007 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130008 INFO (zkCallback-205-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@498adca2 name:ZooKeeperConnection Watcher:127.0.0.1:37481 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130008 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130008 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130008 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 130011 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130013 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130013 INFO (zkCallback-206-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73150ecb name:ZooKeeperConnection Watcher:127.0.0.1:37481/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130013 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130014 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130014 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 130015 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 130015 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 130016 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 130017 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 130017 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 130018 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 130018 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 130019 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 130020 INFO (zkCallback-206-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 130020 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 130022 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 130024 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37481 37481
[junit4] 2> 130199 INFO (Thread-697) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37481 37481
[junit4] 2> 130201 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 130203 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 130203 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 130203 INFO (Thread-698) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 130203 INFO (Thread-698) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 130303 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:38438
[junit4] 2> 130303 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130304 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130306 INFO (zkCallback-208-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7fdc6e57 name:ZooKeeperConnection Watcher:127.0.0.1:38438 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130307 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130307 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130308 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130308 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130312 INFO (zkCallback-209-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@78f6da8f name:ZooKeeperConnection Watcher:127.0.0.1:38438 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130312 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130312 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130312 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 130314 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130314 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130315 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1047084a name:ZooKeeperConnection Watcher:127.0.0.1:38438/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130315 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130316 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130316 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 130317 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 130318 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 130318 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 130319 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 130320 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 130320 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 130320 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 130321 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 130321 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 130322 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 130323 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 130323 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 130323 INFO (zkCallback-210-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 130327 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38438 38438
[junit4] 2> 130507 INFO (Thread-698) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38438 38438
[junit4] 2> 130510 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 130512 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 130512 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 130512 INFO (Thread-699) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 130513 INFO (Thread-699) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 130612 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer start zk server on port:43741
[junit4] 2> 130613 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130618 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130631 INFO (zkCallback-212-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@386e5658 name:ZooKeeperConnection Watcher:127.0.0.1:43741 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130631 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130632 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130662 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130666 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130698 INFO (zkCallback-213-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f01fcd1 name:ZooKeeperConnection Watcher:127.0.0.1:43741 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130702 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130702 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130702 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 130776 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 130786 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 130808 INFO (zkCallback-214-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2dc01d12 name:ZooKeeperConnection Watcher:127.0.0.1:43741/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 130808 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 130808 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 130811 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 130826 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 130842 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 130850 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 130854 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 130855 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 130855 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 130856 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 130858 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 130859 INFO (zkCallback-214-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 130860 INFO (zkCallback-214-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 130861 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 130862 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 130866 INFO (zkCallback-214-thread-2) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 130866 INFO (zkCallback-214-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 130867 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 130870 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b24014540002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 130872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43741 43741
[junit4] 2> 130992 INFO (Thread-699) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43741 43741
[junit4] 2> 130992 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[49CD1522A5B85E3A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 130993 INFO (SUITE-ZkStateReaderTest-seed#[49CD1522A5B85E3A]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_49CD1522A5B85E3A-001
[junit4] 2> Jul 03, 2016 7:33:12 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62), sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=bg, timezone=WET
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=116972904,total=334495744
[junit4] 2> NOTE: All tests run in this JVM: [SpatialHeatmapFacetsTest, TestDocSet, SimpleCollectionCreateDeleteTest, JSONWriterTest, TestArbitraryIndexDir, TestIntervalFaceting, XsltUpdateRequestHandlerTest, TestStandardQParsers, RequestLoggingTest, URLClassifyProcessorTest, TestDefaultStatsCache, HdfsWriteToMultipleCollectionsTest, TestConfigSetProperties, CurrencyFieldOpenExchangeTest, DateFieldTest, TestMaxScoreQueryParser, CursorPagingTest, ActionThrottleTest, TestImplicitCoreProperties, TestMiniSolrCloudClusterBase, DefaultValueUpdateProcessorTest, SolrRequestParserTest, ZkNodePropsTest, TestLRUCache, IndexSchemaTest, ZkStateReaderTest]
[junit4] Completed [54/619 (1!)] on J0 in 2.73s, 6 tests, 1 failure <<< FAILURES!
[...truncated 1844 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984: There were test failures: 619 suites (10 ignored), 2597 tests, 1 failure, 86 ignored (71 assumptions) [seed: 49CD1522A5B85E3A]
Total time: 67 minutes 5 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-Tests-6.x - Build # 311 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/311/
4 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:C71EE30D3FCD41DC]:0)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
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:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
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)
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:D31F63D6BEF471B0]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
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:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
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)
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:A7EAB25C179B6A4F]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:48)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
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:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
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)
FAILED: org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:BD7806F50F3F4BF5]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2(ZkStateWriterTest.java:322)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
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:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
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 11179 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateWriterTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateWriterTest_CCA512216E94B775-001/init-core-data-001
[junit4] 2> 572355 INFO (SUITE-ZkStateWriterTest-seed#[CCA512216E94B775]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 572358 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSingleExternalCollection
[junit4] 2> 572358 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 572358 INFO (Thread-2226) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 572358 INFO (Thread-2226) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 572458 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:45547
[junit4] 2> 572458 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572459 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572461 INFO (zkCallback-715-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@60e9113a name:ZooKeeperConnection Watcher:127.0.0.1:45547 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572461 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572462 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572462 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572463 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572464 INFO (zkCallback-716-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d2eac0b name:ZooKeeperConnection Watcher:127.0.0.1:45547 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572464 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572464 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572464 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 572468 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572469 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572469 INFO (zkCallback-717-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@fcfd2e8 name:ZooKeeperConnection Watcher:127.0.0.1:45547/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572470 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572470 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572470 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 572471 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 572472 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 572473 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 572473 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 572474 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 572475 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 572475 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 572476 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 572476 INFO (zkCallback-717-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 572477 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 572479 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45547 45547
[junit4] 2> 572605 INFO (Thread-2226) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45547 45547
[junit4] 2> 572606 INFO (TEST-ZkStateWriterTest.testSingleExternalCollection-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSingleExternalCollection
[junit4] 2> 572608 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalModificationToSharedClusterState
[junit4] 2> 572608 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 572608 INFO (Thread-2227) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 572608 INFO (Thread-2227) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 572708 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:44330
[junit4] 2> 572708 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572709 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572712 INFO (zkCallback-719-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@32ca0f3a name:ZooKeeperConnection Watcher:127.0.0.1:44330 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572712 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572712 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572713 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572714 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572714 INFO (zkCallback-720-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5fa91c68 name:ZooKeeperConnection Watcher:127.0.0.1:44330 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572715 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572715 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572715 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 572717 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 572717 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 572718 INFO (zkCallback-721-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6d95a8f3 name:ZooKeeperConnection Watcher:127.0.0.1:44330/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 572718 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 572719 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 572719 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 572720 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 572720 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 572721 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 572722 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 572722 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 572723 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 572723 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 572724 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 572724 INFO (zkCallback-721-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 572725 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
[junit4] 2> 572725 INFO (zkCallback-721-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 572726 INFO (zkCallback-721-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: [0])
[junit4] 2> 572728 INFO (zkCallback-721-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: [0])
[junit4] 2> 572729 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44330 44330
[junit4] 2> 573246 INFO (Thread-2227) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44330 44330
[junit4] 2> 573246 INFO (TEST-ZkStateWriterTest.testExternalModificationToSharedClusterState-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalModificationToSharedClusterState
[junit4] 2> 573248 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSingleLegacyCollection
[junit4] 2> 573249 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 573249 INFO (Thread-2228) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 573249 INFO (Thread-2228) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 573349 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:39049
[junit4] 2> 573349 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573360 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573366 INFO (zkCallback-723-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@626dcdd4 name:ZooKeeperConnection Watcher:127.0.0.1:39049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573366 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573366 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573367 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573368 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573368 INFO (zkCallback-724-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@77223124 name:ZooKeeperConnection Watcher:127.0.0.1:39049 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573368 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573368 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573368 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 573375 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573376 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573376 INFO (zkCallback-725-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45d945f9 name:ZooKeeperConnection Watcher:127.0.0.1:39049/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573376 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573376 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573376 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 573377 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 573377 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 573378 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 573378 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 573378 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 573378 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 573379 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 573379 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 573380 INFO (zkCallback-725-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 573381 INFO (zkCallback-725-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 573381 WARN (zkCallback-725-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 573386 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39049 39049
[junit4] 2> 573485 INFO (Thread-2228) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39049 39049
[junit4] 2> 573485 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSingleLegacyCollection
[junit4] 2> 573487 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalModificationToStateFormat2
[junit4] 2> 573487 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 573487 INFO (Thread-2229) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 573487 INFO (Thread-2229) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 573588 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:53264
[junit4] 2> 573588 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573588 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573592 INFO (zkCallback-727-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d7c0317 name:ZooKeeperConnection Watcher:127.0.0.1:53264 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573592 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573593 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573594 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573594 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573595 INFO (zkCallback-728-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@10d34f6 name:ZooKeeperConnection Watcher:127.0.0.1:53264 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573595 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573595 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573595 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 573597 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573597 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573598 INFO (zkCallback-729-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@552543e6 name:ZooKeeperConnection Watcher:127.0.0.1:53264/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573598 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573598 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573599 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 573599 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 573600 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 573600 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 573601 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 573601 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 573601 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 573601 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 573602 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 573602 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
[junit4] 2> 573603 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c2/state.json
[junit4] 2> 573604 ERROR (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/1149293457@768385f3 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@72bc1ffb[Shutting down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:267)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2> 573609 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53264 53264
[junit4] 2> 573716 INFO (Thread-2229) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53264 53264
[junit4] 2> 573716 INFO (TEST-ZkStateWriterTest.testExternalModificationToStateFormat2-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalModificationToStateFormat2
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateWriterTest -Dtests.method=testExternalModificationToStateFormat2 -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sr-Latn -Dtests.timezone=Europe/London -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.23s J1 | ZkStateWriterTest.testExternalModificationToStateFormat2 <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:BD7806F50F3F4BF5]:0)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2(ZkStateWriterTest.java:322)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 573721 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testZkStateWriterBatching
[junit4] 2> 573721 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 573721 INFO (Thread-2230) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 573721 INFO (Thread-2230) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 573821 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:44163
[junit4] 2> 573821 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573832 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573839 INFO (zkCallback-731-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ba1f150 name:ZooKeeperConnection Watcher:127.0.0.1:44163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573839 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573839 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573840 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573844 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573844 INFO (zkCallback-732-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@472b7b71 name:ZooKeeperConnection Watcher:127.0.0.1:44163 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573844 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573845 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573845 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 573846 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 573847 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 573854 INFO (zkCallback-733-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f8ab739 name:ZooKeeperConnection Watcher:127.0.0.1:44163/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 573854 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 573854 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 573854 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 573855 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 573855 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 573856 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 573866 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 573867 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 573867 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 573867 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 573868 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 573868 INFO (zkCallback-733-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 573868 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c2
[junit4] 2> 573869 INFO (zkCallback-733-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 573869 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 573871 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44163 44163
[junit4] 2> 573989 INFO (Thread-2230) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44163 44163
[junit4] 2> 573990 INFO (TEST-ZkStateWriterTest.testZkStateWriterBatching-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testZkStateWriterBatching
[junit4] 2> 573990 INFO (SUITE-ZkStateWriterTest-seed#[CCA512216E94B775]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateWriterTest_CCA512216E94B775-001
[junit4] 2> Jul 03, 2016 11:14:10 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1276, maxMBSortInHeap=5.515003184709201, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=sr-Latn, timezone=Europe/London
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=315493480,total=522715136
[junit4] 2> NOTE: All tests run in this JVM: [TestWordDelimiterFilterFactory, TestHashQParserPlugin, TestManagedStopFilterFactory, AliasIntegrationTest, TestSortByMinMaxFunction, ZkControllerTest, WordBreakSolrSpellCheckerTest, TermVectorComponentTest, CoreAdminCreateDiscoverTest, InfoHandlerTest, TestCloudInspectUtil, SpellingQueryConverterTest, StressHdfsTest, BlockJoinFacetRandomTest, TestConfigOverlay, TestStressCloudBlindAtomicUpdates, CachingDirectoryFactoryTest, CdcrReplicationHandlerTest, TestRequestForwarding, TestSolrCoreProperties, ZkSolrClientTest, UpdateRequestProcessorFactoryTest, MoreLikeThisHandlerTest, JavabinLoaderTest, TestReRankQParserPlugin, TestStressUserVersions, DistributedSuggestComponentTest, BasicFunctionalityTest, OverseerModifyCollectionTest, TestLRUStatsCache, TestQuerySenderNoQuery, TestConfigSetsAPI, TestDistributedGrouping, RulesTest, SimplePostToolTest, ChaosMonkeySafeLeaderTest, UniqFieldsUpdateProcessorFactoryTest, TimeZoneUtilsTest, TestFieldSortValues, SoftAutoCommitTest, TestHashPartitioner, TestMacros, BitVectorTest, TestLegacyFieldCache, MultiTermTest, HdfsLockFactoryTest, TestQuerySenderListener, TestUninvertingReader, TestSurroundQueryParser, AddSchemaFieldsUpdateProcessorFactoryTest, SortByFunctionTest, DistanceFunctionTest, SuggesterFSTTest, TestDistribIDF, ZkStateWriterTest]
[junit4] Completed [187/619 (1!)] on J1 in 1.90s, 5 tests, 1 failure <<< FAILURES!
[...truncated 351 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_CCA512216E94B775-001/init-core-data-001
[junit4] 2> 900058 INFO (SUITE-ZkStateReaderTest-seed#[CCA512216E94B775]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 900064 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 900064 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 900073 INFO (Thread-2321) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 900073 INFO (Thread-2321) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 900173 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:38770
[junit4] 2> 900173 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900197 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900210 INFO (zkCallback-1060-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4cb86bb3 name:ZooKeeperConnection Watcher:127.0.0.1:38770 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900210 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900210 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900218 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900257 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900275 INFO (zkCallback-1061-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@57d70bde name:ZooKeeperConnection Watcher:127.0.0.1:38770 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900432 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900433 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900433 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 900486 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900488 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900490 INFO (zkCallback-1062-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c425099 name:ZooKeeperConnection Watcher:127.0.0.1:38770/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900490 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900490 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900491 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 900491 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 900492 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 900492 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 900493 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 900493 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 900493 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 900493 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 900494 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 900495 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 900496 INFO (zkCallback-1062-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 900496 WARN (zkCallback-1062-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
[junit4] 2> 900497 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38770 38770
[junit4] 2> 900601 INFO (Thread-2321) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38770 38770
[junit4] 2> 900601 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testExternalCollectionWatchedNotWatched -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Asia/Ashkhabad -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.54s J0 | ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:C71EE30D3FCD41DC]:0)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 900604 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 900605 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 900605 INFO (Thread-2322) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 900605 INFO (Thread-2322) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 900705 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:52875
[junit4] 2> 900705 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900749 INFO (zkCallback-1064-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15c88250 name:ZooKeeperConnection Watcher:127.0.0.1:52875 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900749 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900757 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900791 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900798 INFO (zkCallback-1065-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3b513d48 name:ZooKeeperConnection Watcher:127.0.0.1:52875 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 900806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 900806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 900818 INFO (zkCallback-1066-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44740dff name:ZooKeeperConnection Watcher:127.0.0.1:52875/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 900818 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 900818 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 900824 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 900825 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 900825 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 900826 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 900826 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 900826 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 900827 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 900827 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 900827 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 900828 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 900828 INFO (zkCallback-1066-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 900832 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 900833 INFO (zkCallback-1066-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 900835 INFO (zkCallback-1066-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 900836 WARN (zkCallback-1066-thread-3) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections/c1/state.json]
[junit4] 2> 900836 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52875 52875
[junit4] 2> 901087 INFO (Thread-2322) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52875 52875
[junit4] 2> 901088 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=CCA512216E94B775 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Asia/Ashkhabad -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.49s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([CCA512216E94B775:D31F63D6BEF471B0]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 901090 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 901090 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 901093 INFO (Thread-2323) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 901093 INFO (Thread-2323) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 901269 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:38961
[junit4] 2> 901269 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901285 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901290 INFO (zkCallback-1068-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@38c11643 name:ZooKeeperConnection Watcher:127.0.0.1:38961 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901290 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901290 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901297 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901297 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901304 INFO (zkCallback-1069-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@714f015e name:ZooKeeperConnection Watcher:127.0.0.1:38961 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901304 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901304 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901304 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 901323 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901324 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901324 INFO (zkCallback-1070-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c1d93e3 name:ZooKeeperConnection Watcher:127.0.0.1:38961/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901324 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901324 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901325 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 901325 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 901325 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 901326 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 901326 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 901327 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 901327 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 901327 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 901328 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 901328 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 901329 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 901329 INFO (zkCallback-1070-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 901332 INFO (zkCallback-1070-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 901336 INFO (zkCallback-1070-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 901349 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38961 38961
[junit4] 2> 901451 INFO (Thread-2323) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38961 38961
[junit4] 2> 901452 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 901455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 901456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 901456 INFO (Thread-2324) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 901456 INFO (Thread-2324) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 901556 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:52478
[junit4] 2> 901556 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901557 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901560 INFO (zkCallback-1072-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@35b3a3ee name:ZooKeeperConnection Watcher:127.0.0.1:52478 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901561 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901561 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901562 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901563 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901563 INFO (zkCallback-1073-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17663c52 name:ZooKeeperConnection Watcher:127.0.0.1:52478 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901563 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901564 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901564 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 901566 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901569 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901569 INFO (zkCallback-1074-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6bc830b0 name:ZooKeeperConnection Watcher:127.0.0.1:52478/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901569 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901569 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901569 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 901570 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 901571 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 901571 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 901577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 901577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 901577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 901578 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 901578 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 901580 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 901585 INFO (zkCallback-1074-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 901592 INFO (zkCallback-1074-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 901593 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 901593 INFO (zkCallback-1074-thread-2) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 901593 INFO (zkCallback-1074-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 901596 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 901597 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52478 52478
[junit4] 2> 901772 INFO (Thread-2324) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52478 52478
[junit4] 2> 901773 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 901777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 901778 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 901778 INFO (Thread-2325) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 901778 INFO (Thread-2325) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 901878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer start zk server on port:43551
[junit4] 2> 901878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901889 INFO (zkCallback-1076-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73f13be7 name:ZooKeeperConnection Watcher:127.0.0.1:43551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901893 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901921 INFO (zkCallback-1077-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6902483 name:ZooKeeperConnection Watcher:127.0.0.1:43551 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901921 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901921 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901921 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 901929 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 901929 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 901930 INFO (zkCallback-1078-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@eeaef name:ZooKeeperConnection Watcher:127.0.0.1:43551/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 901930 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 901930 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 901930 INFO (TEST-ZkStateReaderTest.testStateForma
[...truncated too long message...]
Waiting for client to connect to ZooKeeper
[junit4] 2> 902233 INFO (zkCallback-1081-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@496fd353 name:ZooKeeperConnection Watcher:127.0.0.1:57371 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 902233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 902233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 902233 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 902234 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 902234 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 902235 INFO (zkCallback-1082-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@cb13959 name:ZooKeeperConnection Watcher:127.0.0.1:57371/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 902235 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 902235 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 902236 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 902236 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 902237 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 902237 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 902238 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 902238 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 902238 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 902239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 902239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 902239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 902240 INFO (zkCallback-1082-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 902240 INFO (zkCallback-1082-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: [0])
[junit4] 2> 902241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 902241 INFO (zkCallback-1082-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 902241 INFO (zkCallback-1082-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 902242 INFO (zkCallback-1082-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 902244 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57371 57371
[junit4] 2> 902501 INFO (Thread-2326) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57371 57371
[junit4] 2> 902502 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CCA512216E94B775]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 902502 INFO (SUITE-ZkStateReaderTest-seed#[CCA512216E94B775]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_CCA512216E94B775-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1134, maxMBSortInHeap=5.327257604830283, sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=en-CA, timezone=Asia/Ashkhabad
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=338148088,total=505937920
[junit4] 2> NOTE: All tests run in this JVM: [TestCrossCoreJoin, HdfsRecoveryZkTest, TestSmileRequest, TestRangeQuery, OverseerStatusTest, TestDynamicFieldResource, TestDefaultStatsCache, TestHighlightDedupGrouping, DistribJoinFromCollectionTest, TestCollectionAPI, TestRTGBase, TestOrdValues, TestSolr4Spatial, TestStressLucene, TestIBSimilarityFactory, TestUniqueKeyFieldResource, DistributedFacetPivotLargeTest, TestChildDocTransformer, RuleEngineTest, JSONWriterTest, TestNRTOpen, TestDistributedSearch, TestSolrCloudWithKerberosAlt, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ExitableDirectoryReaderTest, TestMergePolicyConfig, TestFieldCacheSort, SpatialRPTFieldTypeTest, UUIDFieldTest, TestPseudoReturnFields, TestConfigSetsAPIZkFailure, TestMaxScoreQueryParser, DistributedSpellCheckComponentTest, DefaultValueUpdateProcessorTest, PeerSyncTest, QueryElevationComponentTest, TestConfigSetProperties, SyncSliceTest, LeaderElectionIntegrationTest, TestFileDictionaryLookup, TestSolrCLIRunExample, CopyFieldTest, TestRestoreCore, TriLevelCompositeIdRoutingTest, TestFieldTypeCollectionResource, SignatureUpdateProcessorFactoryTest, TestBackupRepositoryFactory, DateFieldTest, DistributedQueryElevationComponentTest, TestFastOutputStream, TestCSVLoader, TestAtomicUpdateErrorCases, CreateCollectionCleanupTest, DeleteLastCustomShardedReplicaTest, DisMaxRequestHandlerTest, TestReplicaProperties, TestRuleBasedAuthorizationPlugin, BigEndianAscendingWordSerializerTest, IndexSchemaTest, StandardRequestHandlerTest, TestManagedSchema, TestRemoteStreaming, HdfsCollectionsAPIDistributedZkTest, TestCopyFieldCollectionResource, TestDocBasedVersionConstraints, CoreMergeIndexesAdminHandlerTest, ShardSplitTest, TestFunctionQuery, XsltUpdateRequestHandlerTest, TestGraphTermsQParserPlugin, CdcrReplicationDistributedZkTest, FullHLLTest, TestXmlQParser, TestSlowCompositeReaderWrapper, ResponseLogComponentTest, TestLeaderInitiatedRecoveryThread, TestValueSourceCache, TestClassicSimilarityFactory, ActionThrottleTest, CursorPagingTest, TestSolrConfigHandler, TestOnReconnectListenerSupport, HdfsWriteToMultipleCollectionsTest, TestSSLRandomization, TestNumericTerms64, ClassificationUpdateProcessorFactoryTest, SimpleCollectionCreateDeleteTest, DistanceUnitsTest, BadCopyFieldTest, HdfsDirectoryTest, TestRawTransformer, TestCloudDeleteByQuery, TestStandardQParsers, AnalysisAfterCoreReloadTest, URLClassifyProcessorTest, TestOverriddenPrefixQueryForCustomFieldType, TestDownShardTolerantSearch, ConjunctionSolrSpellCheckerTest, TestFaceting, ZkStateReaderTest]
[junit4] Completed [292/619 (2!)] on J0 in 2.52s, 6 tests, 3 errors <<< FAILURES!
[...truncated 1068 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984: There were test failures: 619 suites (10 ignored), 2597 tests, 3 errors, 1 failure, 87 ignored (72 assumptions) [seed: CCA512216E94B775]
Total time: 71 minutes 36 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any