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 11:21:34 UTC
[JENKINS-EA] Lucene-Solr-6.x-Linux (32bit/jdk-9-ea+125) - Build #
1060 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1060/
Java: 32bit/jdk-9-ea+125 -server -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([E45564BCEBBF95D1:EFEE9590BAE66378]:0)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
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 10673 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_E45564BCEBBF95D1-001/init-core-data-001
[junit4] 2> 26070 INFO (SUITE-ZkStateReaderTest-seed#[E45564BCEBBF95D1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 26072 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 26073 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 26073 INFO (Thread-92) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 26073 INFO (Thread-92) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 26174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:38819
[junit4] 2> 26174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26174 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26177 INFO (zkCallback-37-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ec5c27 name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26177 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26177 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26179 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26179 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26181 INFO (zkCallback-38-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@162896b name:ZooKeeperConnection Watcher:127.0.0.1:38819 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26181 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26181 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26181 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 26186 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26186 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26188 INFO (zkCallback-39-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d55203 name:ZooKeeperConnection Watcher:127.0.0.1:38819/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26188 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26188 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26189 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 26190 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 26191 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 26192 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 26193 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 26194 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 26196 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 26197 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 26200 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 26200 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 26202 INFO (zkCallback-39-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 26203 INFO (zkCallback-39-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> 26208 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 26209 INFO (zkCallback-39-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> 26209 INFO (zkCallback-39-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 26209 INFO (zkCallback-39-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> 26211 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38819 38819
[junit4] 2> 26268 INFO (Thread-92) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38819 38819
[junit4] 2> 26270 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 26274 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 26274 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 26275 INFO (Thread-93) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 26275 INFO (Thread-93) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 26375 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:36711
[junit4] 2> 26375 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26376 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26378 INFO (zkCallback-41-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@123b6ba name:ZooKeeperConnection Watcher:127.0.0.1:36711 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26378 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26378 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26380 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26380 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26381 INFO (zkCallback-42-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d487c9 name:ZooKeeperConnection Watcher:127.0.0.1:36711 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26381 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26382 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26382 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 26387 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26388 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26390 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@645144 name:ZooKeeperConnection Watcher:127.0.0.1:36711/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26390 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26390 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26390 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 26393 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 26394 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 26395 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 26397 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 26398 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 26398 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 26399 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 26403 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 26403 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 26405 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 26409 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 26412 INFO (zkCallback-43-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> 26412 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 26415 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36711 36711
[junit4] 2> 26533 INFO (Thread-93) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36711 36711
[junit4] 2> 26535 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 26548 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 26548 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 26549 INFO (Thread-94) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 26549 INFO (Thread-94) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 26651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:33675
[junit4] 2> 26651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26657 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26660 INFO (zkCallback-45-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ed595 name:ZooKeeperConnection Watcher:127.0.0.1:33675 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26660 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26660 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26661 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26665 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26669 INFO (zkCallback-46-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16dfd39 name:ZooKeeperConnection Watcher:127.0.0.1:33675 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26670 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26670 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26670 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 26672 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26673 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26678 INFO (zkCallback-47-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11e03db name:ZooKeeperConnection Watcher:127.0.0.1:33675/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26678 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26679 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26679 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 26681 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 26682 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 26688 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 26689 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 26690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 26690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 26691 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 26692 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 26693 INFO (zkCallback-47-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 26694 INFO (zkCallback-47-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> 26695 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 26700 WARN (zkCallback-47-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 26701 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33675 33675
[junit4] 2> 26712 INFO (Thread-94) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33675 33675
[junit4] 2> 26713 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 26719 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 26720 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 26720 INFO (Thread-95) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 26720 INFO (Thread-95) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 26820 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:35820
[junit4] 2> 26820 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26822 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26827 INFO (zkCallback-49-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@101da1d name:ZooKeeperConnection Watcher:127.0.0.1:35820 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26827 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26828 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26834 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26834 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26836 INFO (zkCallback-50-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f8512 name:ZooKeeperConnection Watcher:127.0.0.1:35820 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26836 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26836 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26836 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 26840 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 26840 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 26851 INFO (zkCallback-51-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b347e0 name:ZooKeeperConnection Watcher:127.0.0.1:35820/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 26851 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 26851 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 26856 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 26857 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 26860 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 26861 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 26862 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 26863 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 26863 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 26864 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 26865 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 26866 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 26868 INFO (zkCallback-51-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 26869 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35820 35820
[junit4] 2> 26983 INFO (Thread-95) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35820 35820
[junit4] 2> 26984 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testExternalCollectionWatchedNotWatched -Dtests.seed=E45564BCEBBF95D1 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=mt-MT -Dtests.timezone=America/Sao_Paulo -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.27s J0 | ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at __randomizedtesting.SeedInfo.seed([E45564BCEBBF95D1:EFEE9590BAE66378]:0)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
[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> 26989 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 26989 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 26990 INFO (Thread-96) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 26990 INFO (Thread-96) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 27090 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:39897
[junit4] 2> 27090 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27090 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27097 INFO (zkCallback-53-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8b931c name:ZooKeeperConnection Watcher:127.0.0.1:39897 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27097 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27097 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27100 INFO (zkCallback-54-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1692c0f name:ZooKeeperConnection Watcher:127.0.0.1:39897 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27100 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 27103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27105 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@58ea1e name:ZooKeeperConnection Watcher:127.0.0.1:39897/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27105 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27105 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27106 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 27110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 27111 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 27112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 27113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 27115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 27115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 27116 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 27117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 27118 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 27123 INFO (zkCallback-55-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> 27125 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 27126 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 27127 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 27127 INFO (zkCallback-55-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> 27128 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 27132 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39897 39897
[junit4] 2> 27161 INFO (Thread-96) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39897 39897
[junit4] 2> 27164 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 27171 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 27171 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 27172 INFO (Thread-97) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 27172 INFO (Thread-97) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 27275 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer start zk server on port:33719
[junit4] 2> 27275 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27279 INFO (zkCallback-57-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19af8ab name:ZooKeeperConnection Watcher:127.0.0.1:33719 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27280 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27280 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27282 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27288 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27289 INFO (zkCallback-58-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8ff672 name:ZooKeeperConnection Watcher:127.0.0.1:33719 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27289 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 27291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 27291 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 27292 INFO (zkCallback-59-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@148d7fc name:ZooKeeperConnection Watcher:127.0.0.1:33719/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 27292 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 27293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 27293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 27295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 27296 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 27297 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 27298 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 27299 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 27300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 27300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 27301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 27301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 27307 INFO (zkCallback-59-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 27308 INFO (zkCallback-59-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> 27309 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 27310 INFO (zkCallback-59-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> 27310 INFO (zkCallback-59-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> 27310 INFO (zkCallback-59-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 27316 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33719 33719
[junit4] 2> 27542 INFO (Thread-97) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33719 33719
[junit4] 2> 27543 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[E45564BCEBBF95D1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 27545 INFO (SUITE-ZkStateReaderTest-seed#[E45564BCEBBF95D1]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_E45564BCEBBF95D1-001
[junit4] 2> Jul 05, 2016 10:49:51 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=1628, maxMBSortInHeap=5.0189163417974445, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=mt-MT, timezone=America/Sao_Paulo
[junit4] 2> NOTE: Linux 4.4.0-28-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=47211384,total=96468992
[junit4] 2> NOTE: All tests run in this JVM: [CopyFieldTest, EchoParamsTest, DistributedQueryElevationComponentTest, SimpleCollectionCreateDeleteTest, HdfsCollectionsAPIDistributedZkTest, JsonLoaderTest, ZkStateReaderTest]
[junit4] Completed [18/619 (1!)] on J0 in 1.78s, 6 tests, 1 error <<< FAILURES!
[...truncated 1940 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/common-build.xml:530: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:1427: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/lucene/common-build.xml:984: There were test failures: 619 suites (10 ignored), 2595 tests, 1 error, 117 ignored (70 assumptions) [seed: E45564BCEBBF95D1]
Total time: 63 minutes 39 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