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/07 06:03:06 UTC
[JENKINS] Lucene-Solr-6.x-Solaris (64bit/jdk1.8.0) - Build # 249 -
Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Solaris/249/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([11D44301646A6434:1A6FB22D3533929D]:0)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10684 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_11D44301646A6434-001/init-core-data-001
[junit4] 2> 124425 INFO (SUITE-ZkStateReaderTest-seed#[11D44301646A6434]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 124441 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 124441 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 124441 INFO (Thread-328) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 124441 INFO (Thread-328) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 124541 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:35032
[junit4] 2> 124541 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124542 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124545 INFO (zkCallback-112-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ca114b9 name:ZooKeeperConnection Watcher:127.0.0.1:35032 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124545 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124548 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124553 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124553 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124567 INFO (zkCallback-113-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66684da8 name:ZooKeeperConnection Watcher:127.0.0.1:35032 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124567 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124567 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124567 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 124578 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124579 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124580 INFO (zkCallback-114-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@42118caf name:ZooKeeperConnection Watcher:127.0.0.1:35032/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124580 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124581 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124581 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 124582 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 124584 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 124586 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 124587 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 124588 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 124589 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 124589 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 124591 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 124592 INFO (zkCallback-114-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 124593 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 124596 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35032 35032
[junit4] 2> 124618 INFO (Thread-328) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35032 35032
[junit4] 2> 124664 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testExternalCollectionWatchedNotWatched -Dtests.seed=11D44301646A6434 -Dtests.slow=true -Dtests.locale=ar -Dtests.timezone=America/Resolute -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.24s J0 | ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at __randomizedtesting.SeedInfo.seed([11D44301646A6434:1A6FB22D3533929D]:0)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 124675 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 124675 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 124676 INFO (Thread-329) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 124676 INFO (Thread-329) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 124776 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:35969
[junit4] 2> 124777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124777 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124791 INFO (zkCallback-116-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@134f1310 name:ZooKeeperConnection Watcher:127.0.0.1:35969 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124792 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124792 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124793 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124794 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124797 INFO (zkCallback-117-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d61d188 name:ZooKeeperConnection Watcher:127.0.0.1:35969 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 124807 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 124807 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 124809 INFO (zkCallback-118-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@baea514 name:ZooKeeperConnection Watcher:127.0.0.1:35969/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 124809 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 124809 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 124810 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 124811 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 124813 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 124814 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 124816 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 124817 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 124817 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 124818 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 124821 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 124821 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 124824 INFO (zkCallback-118-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 124826 INFO (zkCallback-118-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> 124829 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 124829 INFO (zkCallback-118-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> 124830 INFO (zkCallback-118-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 124836 INFO (zkCallback-118-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> 124836 WARN (zkCallback-118-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> 124842 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35969 35969
[junit4] 2> 125126 INFO (Thread-329) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35969 35969
[junit4] 2> 125133 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 125141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 125141 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 125142 INFO (Thread-330) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 125142 INFO (Thread-330) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 125242 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:46142
[junit4] 2> 125242 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125242 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125284 INFO (zkCallback-120-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@76562c24 name:ZooKeeperConnection Watcher:127.0.0.1:46142 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125284 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125284 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125286 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125287 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125288 INFO (zkCallback-121-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d7555ba name:ZooKeeperConnection Watcher:127.0.0.1:46142 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125288 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125288 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125288 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 125292 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125295 INFO (zkCallback-122-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4f3e194e name:ZooKeeperConnection Watcher:127.0.0.1:46142/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125295 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125296 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 125298 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 125299 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 125305 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 125307 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 125308 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 125309 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 125310 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 125312 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 125316 INFO (zkCallback-122-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 125320 INFO (zkCallback-122-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> 125327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 125329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 125330 INFO (zkCallback-122-thread-2) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 125330 INFO (zkCallback-122-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> 125332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 125336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46142 46142
[junit4] 2> 125362 INFO (Thread-330) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46142 46142
[junit4] 2> 125366 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 125380 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 125380 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 125380 INFO (Thread-331) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 125380 INFO (Thread-331) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 125480 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:53190
[junit4] 2> 125480 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125481 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125489 INFO (zkCallback-124-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@62eeac16 name:ZooKeeperConnection Watcher:127.0.0.1:53190 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125490 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125490 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125493 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125493 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125495 INFO (zkCallback-125-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d9d00f9 name:ZooKeeperConnection Watcher:127.0.0.1:53190 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125495 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125495 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125495 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 125502 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125502 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125503 INFO (zkCallback-126-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@51dc8748 name:ZooKeeperConnection Watcher:127.0.0.1:53190/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125504 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125504 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125504 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 125506 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 125508 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 125510 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 125511 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 125513 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 125513 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 125514 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 125516 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 125516 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 125518 INFO (zkCallback-126-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 125520 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 125521 INFO (zkCallback-126-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> 125523 INFO (zkCallback-126-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 125524 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 0x155c3c3e4470002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 125526 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53190 53190
[junit4] 2> 125578 INFO (Thread-331) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53190 53190
[junit4] 2> 125585 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 125608 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 125608 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 125609 INFO (Thread-332) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 125609 INFO (Thread-332) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 125709 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:45670
[junit4] 2> 125709 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125709 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125714 INFO (zkCallback-128-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3a6ff55 name:ZooKeeperConnection Watcher:127.0.0.1:45670 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125715 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125715 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125717 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125717 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125718 INFO (zkCallback-129-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7f5b8aaf name:ZooKeeperConnection Watcher:127.0.0.1:45670 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125718 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125719 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 125722 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125722 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125725 INFO (zkCallback-130-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6595847e name:ZooKeeperConnection Watcher:127.0.0.1:45670/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125725 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125726 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 125727 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 125729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 125730 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 125732 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 125733 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 125734 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 125735 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 125737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 125737 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 125738 INFO (zkCallback-130-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 125740 INFO (zkCallback-130-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> 125741 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 125741 INFO (zkCallback-130-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> 125742 INFO (zkCallback-130-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 125742 INFO (zkCallback-130-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> 125746 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45670 45670
[junit4] 2> 125753 INFO (Thread-332) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45670 45670
[junit4] 2> 125754 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 125757 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 125758 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 125758 INFO (Thread-333) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 125758 INFO (Thread-333) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 125858 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer start zk server on port:63588
[junit4] 2> 125858 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125859 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125861 INFO (zkCallback-132-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73cb3c88 name:ZooKeeperConnection Watcher:127.0.0.1:63588 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125861 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125861 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125868 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125868 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125872 INFO (zkCallback-133-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f7eeed6 name:ZooKeeperConnection Watcher:127.0.0.1:63588 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125872 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 125876 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 125876 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 125877 INFO (zkCallback-134-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@46885826 name:ZooKeeperConnection Watcher:127.0.0.1:63588/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 125877 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 125878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 125878 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 125881 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 125883 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 125884 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 125886 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 125887 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 125888 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 125889 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 125890 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 125892 INFO (zkCallback-134-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 125895 INFO (zkCallback-134-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> 125897 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 125898 INFO (zkCallback-134-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> 125902 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63588 63588
[junit4] 2> 125930 INFO (Thread-333) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63588 63588
[junit4] 2> 125964 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[11D44301646A6434]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 125965 INFO (SUITE-ZkStateReaderTest-seed#[11D44301646A6434]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_11D44301646A6434-001
[junit4] 2> Jul 07, 2016 5:10:43 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=1955, maxMBSortInHeap=7.417673077891706, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=ar, timezone=America/Resolute
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=18577224,total=127488000
[junit4] 2> NOTE: All tests run in this JVM: [StressHdfsTest, ZkControllerTest, SolrCLIZkUtilsTest, HighlighterTest, UUIDFieldTest, TermsComponentTest, CdcrUpdateLogTest, TestFieldCacheReopen, ExternalFileFieldSortTest, TestJmxIntegration, TestRemoteStreaming, SystemInfoHandlerTest, HdfsRestartWhileUpdatingTest, HLLUtilTest, ZkStateReaderTest]
[junit4] Completed [41/621 (1!)] on J0 in 2.09s, 6 tests, 1 error <<< FAILURES!
[...truncated 1883 lines...]
BUILD FAILED
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/build.xml:740: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/build.xml:684: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/build.xml:59: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/build.xml:233: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/solr/common-build.xml:530: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/lucene/common-build.xml:1427: The following error occurred while executing this line:
/export/home/jenkins/workspace/Lucene-Solr-6.x-Solaris/lucene/common-build.xml:984: There were test failures: 621 suites (10 ignored), 2642 tests, 1 error, 103 ignored (88 assumptions) [seed: 11D44301646A6434]
Total time: 77 minutes 29 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