You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/07/05 08:20:06 UTC
[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-9-ea+125) - Build
# 17154 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17154/
Java: 64bit/jdk-9-ea+125 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
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([55CC3B6BD49551B7:4A764A9C04F59772]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533)
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(java.base@9-ea/Thread.java:843)
Build Log:
[...truncated 10928 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_55CC3B6BD49551B7-001/init-core-data-001
[junit4] 2> 355767 INFO (SUITE-ZkStateReaderTest-seed#[55CC3B6BD49551B7]-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> 355768 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 355768 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 355768 INFO (Thread-1361) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 355768 INFO (Thread-1361) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 355868 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:34868
[junit4] 2> 355869 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 355869 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 355872 INFO (zkCallback-444-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@52ed3db name:ZooKeeperConnection Watcher:127.0.0.1:34868 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 355872 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 355873 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 355873 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 0x155ba0eb1690000, 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(java.base@9-ea/Thread.java:843)
[junit4] 2> 355874 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 355882 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 355883 INFO (zkCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3e74bedc name:ZooKeeperConnection Watcher:127.0.0.1:34868 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 355883 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 355883 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 355883 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 355885 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 355886 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 355887 INFO (zkCallback-446-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5f8f0dc2 name:ZooKeeperConnection Watcher:127.0.0.1:34868/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 355887 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 355887 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 355887 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 355888 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 355888 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 355888 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 355889 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 355889 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 355889 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 355889 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 355891 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 355891 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 355892 INFO (zkCallback-446-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 355893 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 355893 INFO (zkCallback-446-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> 355893 INFO (zkCallback-446-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 355899 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34868 34868
[junit4] 2> 355921 INFO (Thread-1361) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34868 34868
[junit4] 2> 355921 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 355923 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 355923 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 355924 INFO (Thread-1362) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 355924 INFO (Thread-1362) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 356024 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:33583
[junit4] 2> 356024 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356024 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356025 INFO (zkCallback-448-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@61da577c name:ZooKeeperConnection Watcher:127.0.0.1:33583 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356026 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356026 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356026 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356027 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356027 INFO (zkCallback-449-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@18c2a43b name:ZooKeeperConnection Watcher:127.0.0.1:33583 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356027 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356028 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356028 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 356029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356029 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356030 INFO (zkCallback-450-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7943e1ff name:ZooKeeperConnection Watcher:127.0.0.1:33583/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356030 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 356031 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 356031 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 356032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 356032 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 356033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 356033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 356033 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 356034 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 356035 INFO (zkCallback-450-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 356035 INFO (zkCallback-450-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> 356036 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 356036 INFO (zkCallback-450-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> 356037 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33583 33583
[junit4] 2> 356137 INFO (Thread-1362) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33583 33583
[junit4] 2> 356138 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 356139 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 356140 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 356140 INFO (Thread-1363) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 356140 INFO (Thread-1363) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 356240 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:39251
[junit4] 2> 356240 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356241 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356243 INFO (zkCallback-452-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@60ee109f name:ZooKeeperConnection Watcher:127.0.0.1:39251 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356243 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356243 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356245 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356246 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356246 INFO (zkCallback-453-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@723a78f5 name:ZooKeeperConnection Watcher:127.0.0.1:39251 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356247 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356247 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356247 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 356248 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356248 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356249 INFO (zkCallback-454-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@395135d name:ZooKeeperConnection Watcher:127.0.0.1:39251/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356249 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356250 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356250 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 356251 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 356252 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 356252 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 356253 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 356253 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 356253 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 356254 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 356254 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 356255 INFO (zkCallback-454-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 356255 INFO (zkCallback-454-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> 356256 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 356256 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 356257 INFO (zkCallback-454-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 356257 INFO (zkCallback-454-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> 356258 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 356259 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39251 39251
[junit4] 2> 356281 INFO (Thread-1363) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39251 39251
[junit4] 2> 356281 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 356283 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 356283 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 356283 INFO (Thread-1364) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 356283 INFO (Thread-1364) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 356383 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:42981
[junit4] 2> 356383 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356384 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356385 INFO (zkCallback-456-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6ab87a99 name:ZooKeeperConnection Watcher:127.0.0.1:42981 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356385 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356385 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356386 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356387 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356390 INFO (zkCallback-457-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6450c932 name:ZooKeeperConnection Watcher:127.0.0.1:42981 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356390 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356390 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356390 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 356391 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356396 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356398 INFO (zkCallback-458-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@62cd2328 name:ZooKeeperConnection Watcher:127.0.0.1:42981/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356398 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356401 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 356402 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 356403 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 356403 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 356404 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 356404 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 356405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 356405 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 356411 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 356414 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 356417 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 356419 INFO (zkCallback-458-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 356419 INFO (zkCallback-458-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> 356426 INFO (zkCallback-458-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> 356426 INFO (zkCallback-458-thread-3) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 356428 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42981 42981
[junit4] 2> 356456 INFO (Thread-1364) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42981 42981
[junit4] 2> 356457 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=55CC3B6BD49551B7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=rn-BI -Dtests.timezone=Etc/GMT-14 -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.18s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([55CC3B6BD49551B7:4A764A9C04F59772]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
[junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
[junit4] > at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
[junit4] 2> 356463 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 356464 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 356464 INFO (Thread-1365) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 356464 INFO (Thread-1365) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 356564 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:44671
[junit4] 2> 356564 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356566 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356570 INFO (zkCallback-460-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7e589aab name:ZooKeeperConnection Watcher:127.0.0.1:44671 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356570 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356570 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356574 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356575 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356577 INFO (zkCallback-461-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@344597bc name:ZooKeeperConnection Watcher:127.0.0.1:44671 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 356579 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356580 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356581 INFO (zkCallback-462-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@368b2441 name:ZooKeeperConnection Watcher:127.0.0.1:44671/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356582 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356582 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356583 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 356584 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 356585 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 356587 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 356588 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 356588 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 356589 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 356589 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 356590 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 356590 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 356591 INFO (zkCallback-462-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 356614 INFO (zkCallback-462-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> 356615 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 356615 INFO (zkCallback-462-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> 356615 INFO (zkCallback-462-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 356615 INFO (zkCallback-462-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> 356617 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44671 44671
[junit4] 2> 356842 INFO (Thread-1365) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44671 44671
[junit4] 2> 356843 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 356844 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 356845 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 356845 INFO (Thread-1366) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 356845 INFO (Thread-1366) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 356945 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer start zk server on port:36235
[junit4] 2> 356945 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356946 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356950 INFO (zkCallback-464-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1fca5325 name:ZooKeeperConnection Watcher:127.0.0.1:36235 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356950 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356951 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356951 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356952 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356952 INFO (zkCallback-465-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2e28df55 name:ZooKeeperConnection Watcher:127.0.0.1:36235 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356952 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356953 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356953 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 356954 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 356955 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 356955 INFO (zkCallback-466-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1defc22e name:ZooKeeperConnection Watcher:127.0.0.1:36235/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 356955 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 356955 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 356955 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 356956 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 356957 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 356957 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 356958 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 356959 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 356959 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 356959 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 356960 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 356961 INFO (zkCallback-466-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 356961 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 356962 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 356963 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36235 36235
[junit4] 2> 356984 INFO (Thread-1366) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36235 36235
[junit4] 2> 356985 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[55CC3B6BD49551B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 356986 INFO (SUITE-ZkStateReaderTest-seed#[55CC3B6BD49551B7]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_55CC3B6BD49551B7-001
[junit4] 2> Jul 05, 2016 7:56:14 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1764, maxMBSortInHeap=5.904208523378417, sim=ClassicSimilarity, locale=rn-BI, timezone=Etc/GMT-14
[junit4] 2> NOTE: Linux 4.4.0-28-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=311297840,total=529530880
[junit4] 2> NOTE: All tests run in this JVM: [TestUninvertingReader, TestOnReconnectListenerSupport, TolerantUpdateProcessorTest, TestUseDocValuesAsStored, TestCustomSort, TestPhraseSuggestions, BasicDistributedZkTest, JsonLoaderTest, SpatialHeatmapFacetsTest, TestAuthorizationFramework, TestLRUStatsCache, TestFoldingMultitermQuery, RequestLoggingTest, IndexSchemaTest, DistributedFacetPivotLargeTest, TestReloadDeadlock, CdcrReplicationDistributedZkTest, TestRealTimeGet, AnalyticsQueryTest, TestGeoJSONResponseWriter, TestChildDocTransformer, CoreMergeIndexesAdminHandlerTest, TestDistributedSearch, TestRangeQuery, TestIntervalFaceting, TestOrdValues, SystemInfoHandlerTest, TestMaxScoreQueryParser, TestCloudDeleteByQuery, TestLegacyFieldCache, TestComponentsName, SyncSliceTest, BlockJoinFacetDistribTest, ZkStateReaderTest]
[junit4] Completed [116/618 (1!)] on J0 in 1.99s, 6 tests, 1 error <<< FAILURES!
[...truncated 1617 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:530: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1427: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: There were test failures: 618 suites (10 ignored), 2588 tests, 1 error, 117 ignored (70 assumptions) [seed: 55CC3B6BD49551B7]
Total time: 55 minutes 31 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+125) - Build
# 17155 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17155/
Java: 32bit/jdk-9-ea+125 -server -XX:+UseParallelGC
2 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([2E6773E040DCDBEC:51F9C46529BEF666]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533)
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(java.base@9-ea/Thread.java:843)
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([2E6773E040DCDBEC:31DD021790BC1D29]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533)
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(java.base@9-ea/Thread.java:843)
Build Log:
[...truncated 12189 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_2E6773E040DCDBEC-001/init-core-data-001
[junit4] 2> 1593344 INFO (SUITE-ZkStateReaderTest-seed#[2E6773E040DCDBEC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1593345 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1593345 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1593345 INFO (Thread-4725) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1593345 INFO (Thread-4725) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1593445 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:37727
[junit4] 2> 1593445 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593446 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593447 INFO (zkCallback-2091-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@147d1eb name:ZooKeeperConnection Watcher:127.0.0.1:37727 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593447 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593448 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593448 INFO (zkCallback-2092-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@be0a77 name:ZooKeeperConnection Watcher:127.0.0.1:37727 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593448 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593448 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593448 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1593452 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593452 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593453 INFO (zkCallback-2093-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1cc0cd6 name:ZooKeeperConnection Watcher:127.0.0.1:37727/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593453 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593453 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1593455 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1593456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1593456 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1593457 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1593458 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1593458 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1593458 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1593459 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1593459 INFO (zkCallback-2093-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1593460 INFO (zkCallback-2093-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> 1593460 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1593461 INFO (zkCallback-2093-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> 1593461 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37727 37727
[junit4] 2> 1593472 INFO (Thread-4725) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37727 37727
[junit4] 2> 1593472 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1593474 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1593476 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1593476 INFO (Thread-4726) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1593476 INFO (Thread-4726) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1593576 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:39301
[junit4] 2> 1593576 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593577 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593577 INFO (zkCallback-2095-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b08522 name:ZooKeeperConnection Watcher:127.0.0.1:39301 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593578 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593578 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593578 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593579 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593579 INFO (zkCallback-2096-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@97d4c6 name:ZooKeeperConnection Watcher:127.0.0.1:39301 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593579 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593579 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593580 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1593581 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1593581 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1593581 INFO (zkCallback-2097-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a3e3a5 name:ZooKeeperConnection Watcher:127.0.0.1:39301/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1593582 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1593582 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1593582 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1593583 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1593584 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1593584 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1593585 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1593585 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1593585 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1593586 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1593586 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1593586 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1593587 INFO (zkCallback-2097-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1593588 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1593589 INFO (zkCallback-2097-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> 1593589 INFO (zkCallback-2097-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> 1595090 WARN (zkCallback-2097-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> 1595091 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39301 39301
[junit4] 2> 1595238 INFO (Thread-4726) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39301 39301
[junit4] 2> 1595239 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=2E6773E040DCDBEC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sk -Dtests.timezone=Etc/UTC -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 1.77s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([2E6773E040DCDBEC:31DD021790BC1D29]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
[junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
[junit4] > at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
[junit4] 2> 1595244 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 1595244 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1595244 INFO (Thread-4727) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1595244 INFO (Thread-4727) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1595344 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:40541
[junit4] 2> 1595344 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595345 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595346 INFO (zkCallback-2099-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b3240a name:ZooKeeperConnection Watcher:127.0.0.1:40541 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595346 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595348 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595348 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595348 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595349 INFO (zkCallback-2100-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ab914d name:ZooKeeperConnection Watcher:127.0.0.1:40541 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595349 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595349 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595349 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1595359 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595360 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595376 INFO (zkCallback-2101-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1edef60 name:ZooKeeperConnection Watcher:127.0.0.1:40541/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595376 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595376 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595376 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1595377 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1595391 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1595392 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1595392 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1595395 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1595396 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1595396 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1595397 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1595399 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1595399 INFO (zkCallback-2101-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1595414 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1595414 INFO (zkCallback-2101-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> 1595415 INFO (zkCallback-2101-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1595416 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40541 40541
[junit4] 2> 1595530 INFO (Thread-4727) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40541 40541
[junit4] 2> 1595530 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 1595533 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1595533 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1595534 INFO (Thread-4728) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1595534 INFO (Thread-4728) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1595634 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:34384
[junit4] 2> 1595634 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595634 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595636 INFO (zkCallback-2103-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1469935 name:ZooKeeperConnection Watcher:127.0.0.1:34384 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595636 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595637 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595637 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595638 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595639 INFO (zkCallback-2104-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e869ba name:ZooKeeperConnection Watcher:127.0.0.1:34384 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595640 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595640 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595640 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1595641 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595641 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595642 INFO (zkCallback-2105-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@256aae name:ZooKeeperConnection Watcher:127.0.0.1:34384/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595642 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595643 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595643 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1595644 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1595644 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1595645 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1595645 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1595646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1595646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1595646 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1595648 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1595648 INFO (zkCallback-2105-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1595648 INFO (zkCallback-2105-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> 1595649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1595650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1595650 INFO (zkCallback-2105-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 1595650 INFO (zkCallback-2105-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> 1595655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1595655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34384 34384
[junit4] 2> 1595768 INFO (Thread-4728) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34384 34384
[junit4] 2> 1595769 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1595771 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 1595772 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1595772 INFO (Thread-4729) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1595772 INFO (Thread-4729) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1595872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:35338
[junit4] 2> 1595872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595873 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595874 INFO (zkCallback-2107-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2441c6 name:ZooKeeperConnection Watcher:127.0.0.1:35338 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595874 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595874 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595876 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595876 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595877 INFO (zkCallback-2108-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b473d9 name:ZooKeeperConnection Watcher:127.0.0.1:35338 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595877 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595877 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595877 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1595878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1595880 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1595880 INFO (zkCallback-2109-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e86fd6 name:ZooKeeperConnection Watcher:127.0.0.1:35338/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1595880 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1595880 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1595881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1595881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1595882 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1595882 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1595883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1595883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1595883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1595884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1595884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1595884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1595885 INFO (zkCallback-2109-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1595885 INFO (zkCallback-2109-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> 1595886 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1595886 INFO (zkCallback-2109-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> 1595888 INFO (zkCallback-2109-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1595888 INFO (zkCallback-2109-thread-3) [ ] 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> 1595890 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35338 35338
[junit4] 2> 1595984 INFO (Thread-4729) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35338 35338
[junit4] 2> 1595984 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=2E6773E040DCDBEC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sk -Dtests.timezone=Etc/UTC -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.22s J0 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<2> but was:<1>
[junit4] > at __randomizedtesting.SeedInfo.seed([2E6773E040DCDBEC:51F9C46529BEF666]: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 jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
[junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
[junit4] > at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
[junit4] 2> 1595987 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 1595987 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1595987 INFO (Thread-4730) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1595987 INFO (Thread-4730) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1596087 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer start zk server on port:42842
[junit4] 2> 1596088 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1596088 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1596089 INFO (zkCallback-2111-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4c054b name:ZooKeeperConnection Watcher:127.0.0.1:42842 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1596089 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1596090 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1596091 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1596092 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1596092 INFO (zkCallback-2112-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9ca0fe name:ZooKeeperConnection Watcher:127.0.0.1:42842 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1596092 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1596093 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1596093 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1596094 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1596094 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1596095 INFO (zkCallback-2113-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ec7e6f name:ZooKeeperConnection Watcher:127.0.0.1:42842/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1596095 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1596095 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1596095 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1596096 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1596096 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1596097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1596097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1596098 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1596098 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1596098 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1596099 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1596099 INFO (zkCallback-2113-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1596100 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1596100 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1596101 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42842 42842
[junit4] 2> 1596202 INFO (Thread-4730) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42842 42842
[junit4] 2> 1596203 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[2E6773E040DCDBEC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 1596204 INFO (SUITE-ZkStateReaderTest-seed#[2E6773E040DCDBEC]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_2E6773E040DCDBEC-001
[junit4] 2> Jul 05, 2016 10:14:14 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=269, maxMBSortInHeap=7.5262322581823, sim=ClassicSimilarity, locale=sk, timezone=Etc/UTC
[junit4] 2> NOTE: Linux 4.4.0-28-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=194095104,total=401080320
[junit4] 2> NOTE: All tests run in this JVM: [TestOrdValues, TestCloudDeleteByQuery, RuleEngineTest, EchoParamsTest, URLClassifyProcessorTest, TestIntervalFaceting, FileBasedSpellCheckerTest, DistributedFacetPivotSmallTest, ResponseLogComponentTest, TestConfigSetsAPIZkFailure, TestOnReconnectListenerSupport, TestDistributedStatsComponentCardinality, PolyFieldTest, TestSlowCompositeReaderWrapper, TestDynamicFieldResource, CacheHeaderTest, TestSmileRequest, TestFieldCacheSortRandom, TestHighlightDedupGrouping, QueryEqualityTest, CoreMergeIndexesAdminHandlerTest, ExternalFileFieldSortTest, DeleteLastCustomShardedReplicaTest, TestAnalyzedSuggestions, PingRequestHandlerTest, TestAtomicUpdateErrorCases, TestComponentsName, TestDistributedSearch, PeerSyncTest, BitVectorTest, TestRestoreCore, ResourceLoaderTest, SyncSliceTest, LeaderElectionIntegrationTest, TestStandardQParsers, TestHdfsBackupRestoreCore, XsltUpdateRequestHandlerTest, BlockJoinFacetDistribTest, ParsingFieldUpdateProcessorsTest, BlockDirectoryTest, TriLevelCompositeIdRoutingTest, BasicDistributedZkTest, TestClassicSimilarityFactory, SynonymTokenizerTest, TestSolrConfigHandlerConcurrent, IndexSchemaRuntimeFieldTest, TestMaxScoreQueryParser, RequestLoggingTest, ZkNodePropsTest, TestFastOutputStream, TestFoldingMultitermQuery, RankQueryTest, TestManagedSchema, ConcurrentDeleteAndCreateCollectionTest, BadCopyFieldTest, TestIBSimilarityFactory, ShardSplitTest, IndexSchemaTest, TestReplicationHandler, HdfsBasicDistributedZkTest, AlternateDirectoryTest, TestReplicaProperties, SolrXmlInZkTest, TestOverriddenPrefixQueryForCustomFieldType, TestCSVLoader, TestPhraseSuggestions, TestFunctionQuery, TestRealTimeGet, TestSubQueryTransformerDistrib, CollectionTooManyReplicasTest, CdcrUpdateLogTest, SolrCoreTest, HLLSerializationTest, SolrRequestParserTest, TestRandomFaceting, HdfsCollectionsAPIDistributedZkTest, TestRestManager, AsyncCallRequestStatusResponseTest, RollingRestartTest, TestBadConfig, TestPseudoReturnFields, TestSolrCloudWithKerberosAlt, TestFieldTypeCollectionResource, TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterBase, TestTestInjection, RAMDirectoryFactoryTest, TestDocSet, AnalyticsQueryTest, HdfsLockFactoryTest, CdcrReplicationDistributedZkTest, TestDistribIDF, SignatureUpdateProcessorFactoryTest, TestLRUStatsCache, CurrencyFieldOpenExchangeTest, TestLMDirichletSimilarityFactory, TestBinaryField, TestChildDocTransformer, TestTrackingShardHandlerFactory, TestRandomDVFaceting, TermVectorComponentDistributedTest, TestJoin, DistributedTermsComponentTest, QueryElevationComponentTest, BasicFunctionalityTest, DistributedQueryElevationComponentTest, SimplePostToolTest, AnalysisAfterCoreReloadTest, SuggesterTest, NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestUpdate, TestWordDelimiterFilterFactory, TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest, SolrInfoMBeanTest, DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf, DocumentAnalysisRequestHandlerTest, TermsComponentTest, RequestHandlersTest, PathHierarchyTokenizerFactoryTest, TestIndexingPerformance, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, ReturnFieldsTest, UniqFieldsUpdateProcessorFactoryTest, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, HighlighterConfigTest, SOLR749Test, UpdateParamsTest, TestQuerySenderNoQuery, SolrIndexConfigTest, TestSolrDeletionPolicy2, SampleTest, TestFuzzyAnalyzedSuggestions, TestPostingsSolrHighlighter, DirectSolrConnectionTest, TestCharFilters, TestCodecSupport, TestLMJelinekMercerSimilarityFactory, TestJmxMonitoredMap, ScriptEngineTest, DateMathParserTest, PrimUtilsTest, ClusterStateTest, TestUtils, SystemInfoHandlerTest, DistributedMLTComponentTest, DistributedIntervalFacetingTest, AliasIntegrationTest, CleanupOldIndexTest, CollectionReloadTest, DeleteStatusTest, DistribCursorPagingTest, DistributedQueueTest, ForceLeaderTest, RemoteQueryErrorTest, TestCryptoKeys, TestRebalanceLeaders, TestShortCircuitedRequests, TlogReplayBufferedWhileIndexingTest, HdfsBasicDistributedZk2Test, HdfsChaosMonkeyNothingIsSafeTest, HdfsNNFailoverTest, HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, ZkStateReaderTest]
[junit4] Completed [503/618 (1!)] on J0 in 3.62s, 6 tests, 1 failure, 1 error <<< FAILURES!
[...truncated 358 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:530: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1427: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: There were test failures: 618 suites (10 ignored), 2588 tests, 1 error, 1 failure, 117 ignored (70 assumptions) [seed: 2E6773E040DCDBEC]
Total time: 54 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any