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 15:26:20 UTC
[JENKINS-EA] Lucene-Solr-6.x-Linux (64bit/jdk-9-ea+125) - Build #
1062 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1062/
Java: 64bit/jdk-9-ea+125 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched
Error Message:
Stack Trace:
java.lang.NullPointerException
at __randomizedtesting.SeedInfo.seed([CD161EE3B555190D:C6ADEFCFE40CEFA4]: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)
FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at __randomizedtesting.SeedInfo.seed([CD161EE3B555190D:D2AC6F146535DFC8]:0)
at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:533)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
Build Log:
[...truncated 12210 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/J1/temp/solr.cloud.overseer.ZkStateReaderTest_CD161EE3B555190D-001/init-core-data-001
[junit4] 2> 1560990 INFO (SUITE-ZkStateReaderTest-seed#[CD161EE3B555190D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1560991 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 1560991 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1560991 INFO (Thread-4140) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1560991 INFO (Thread-4140) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1561091 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:41516
[junit4] 2> 1561091 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561092 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561093 INFO (zkCallback-1906-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e64865a name:ZooKeeperConnection Watcher:127.0.0.1:41516 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561093 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561094 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561094 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561097 INFO (zkCallback-1907-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5f2a2313 name:ZooKeeperConnection Watcher:127.0.0.1:41516 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561097 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1561099 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561099 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561100 INFO (zkCallback-1908-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@146ab02c name:ZooKeeperConnection Watcher:127.0.0.1:41516/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561100 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561100 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561100 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1561101 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1561102 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1561102 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1561103 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1561103 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1561104 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1561104 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1561105 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1561106 INFO (zkCallback-1908-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1561106 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1561120 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41516 41516
[junit4] 2> 1561213 INFO (Thread-4140) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41516 41516
[junit4] 2> 1561215 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testExternalCollectionWatchedNotWatched -Dtests.seed=CD161EE3B555190D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=se-SE -Dtests.timezone=Asia/Tashkent -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.23s J1 | ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at __randomizedtesting.SeedInfo.seed([CD161EE3B555190D:C6ADEFCFE40CEFA4]: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> 1561219 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1561219 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1561219 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1561219 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1561319 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:41685
[junit4] 2> 1561319 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561320 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561321 INFO (zkCallback-1910-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7d79b3d4 name:ZooKeeperConnection Watcher:127.0.0.1:41685 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561323 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561326 INFO (zkCallback-1911-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2e1bdf30 name:ZooKeeperConnection Watcher:127.0.0.1:41685 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1561329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561329 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561330 INFO (zkCallback-1912-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5906154f name:ZooKeeperConnection Watcher:127.0.0.1:41685/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1561331 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1561332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1561332 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1561333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1561333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1561334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1561334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1561335 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1561336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1561337 INFO (zkCallback-1912-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> 1561337 INFO (zkCallback-1912-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1561338 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1561341 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$136/964659296@141c5f6e rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@511ed389[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(java.base@9-ea/ThreadPoolExecutor.java:2073)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(java.base@9-ea/ThreadPoolExecutor.java:839)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(java.base@9-ea/ThreadPoolExecutor.java:1385)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(java.base@9-ea/AbstractExecutorService.java:118)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:267)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2> 1561341 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41685 41685
[junit4] 2> 1561342 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$136/964659296@6005e357 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@511ed389[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 3]
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(java.base@9-ea/ThreadPoolExecutor.java:2073)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(java.base@9-ea/ThreadPoolExecutor.java:839)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(java.base@9-ea/ThreadPoolExecutor.java:1385)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(java.base@9-ea/AbstractExecutorService.java:118)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:267)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2> 1561545 INFO (Thread-4141) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:41685 41685
[junit4] 2> 1561546 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=CD161EE3B555190D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=se-SE -Dtests.timezone=Asia/Tashkent -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.33s J1 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
[junit4] > at __randomizedtesting.SeedInfo.seed([CD161EE3B555190D:D2AC6F146535DFC8]:0)
[junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129)
[junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:43)
[junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
[junit4] > at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
[junit4] > at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
[junit4] 2> 1561548 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 1561548 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1561548 INFO (Thread-4142) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1561548 INFO (Thread-4142) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1561648 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:44693
[junit4] 2> 1561648 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561649 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561650 INFO (zkCallback-1914-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@708c6e60 name:ZooKeeperConnection Watcher:127.0.0.1:44693 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561650 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561650 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561651 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561652 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561652 INFO (zkCallback-1915-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b37d898 name:ZooKeeperConnection Watcher:127.0.0.1:44693 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561652 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561652 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561652 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1561654 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561655 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561655 INFO (zkCallback-1916-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ef2b658 name:ZooKeeperConnection Watcher:127.0.0.1:44693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561655 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561656 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561656 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1561657 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1561657 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1561657 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1561658 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1561658 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1561659 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1561659 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1561661 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1561661 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1561661 INFO (zkCallback-1916-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1561662 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1561662 INFO (zkCallback-1916-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> 1561662 INFO (zkCallback-1916-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1561664 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44693 44693
[junit4] 2> 1561782 INFO (Thread-4142) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44693 44693
[junit4] 2> 1561782 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 1561785 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 1561785 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1561785 INFO (Thread-4143) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1561785 INFO (Thread-4143) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1561885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:36289
[junit4] 2> 1561885 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561896 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561904 INFO (zkCallback-1918-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f5bdd58 name:ZooKeeperConnection Watcher:127.0.0.1:36289 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561904 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561905 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561906 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561908 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561912 INFO (zkCallback-1919-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@700b4b9d name:ZooKeeperConnection Watcher:127.0.0.1:36289 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561912 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561912 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561912 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1561914 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1561924 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1561939 INFO (zkCallback-1920-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@a9be87c name:ZooKeeperConnection Watcher:127.0.0.1:36289/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1561939 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1561939 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1561940 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1561942 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1561943 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1561948 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1561949 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1561949 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1561950 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1561950 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1561951 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1561951 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1561954 INFO (zkCallback-1920-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1561974 INFO (zkCallback-1920-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> 1561975 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1561976 INFO (zkCallback-1920-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> 1561976 INFO (zkCallback-1920-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 1561976 INFO (zkCallback-1920-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1561988 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36289 36289
[junit4] 2> 1561994 INFO (Thread-4143) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36289 36289
[junit4] 2> 1561994 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 1561998 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1561998 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1561998 INFO (Thread-4144) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1561998 INFO (Thread-4144) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1562098 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:43056
[junit4] 2> 1562099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562099 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562100 INFO (zkCallback-1922-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45d2dcb7 name:ZooKeeperConnection Watcher:127.0.0.1:43056 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562100 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562101 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562102 INFO (zkCallback-1923-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2cfa7487 name:ZooKeeperConnection Watcher:127.0.0.1:43056 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562102 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562102 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562102 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1562103 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562104 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562105 INFO (zkCallback-1924-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@33f32980 name:ZooKeeperConnection Watcher:127.0.0.1:43056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562105 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562105 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562106 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1562106 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1562108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1562108 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1562109 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1562109 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1562110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1562110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1562110 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1562111 INFO (zkCallback-1924-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1562111 INFO (zkCallback-1924-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> 1562112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1562112 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1562113 INFO (zkCallback-1924-thread-1) [ ] o.a.s.c.c.ZkStateReader Uninteresting collection c1
[junit4] 2> 1562113 INFO (zkCallback-1924-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> 1562113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1562114 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43056 43056
[junit4] 2> 1562219 INFO (Thread-4144) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43056 43056
[junit4] 2> 1562220 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1562221 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1562221 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1562221 INFO (Thread-4145) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1562221 INFO (Thread-4145) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1562321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer start zk server on port:44801
[junit4] 2> 1562321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562325 INFO (zkCallback-1926-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@13dc43f1 name:ZooKeeperConnection Watcher:127.0.0.1:44801 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562325 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562325 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562328 INFO (zkCallback-1927-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@37a0441a name:ZooKeeperConnection Watcher:127.0.0.1:44801 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562328 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562328 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562328 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1562330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1562330 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1562331 INFO (zkCallback-1928-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7bd7632c name:ZooKeeperConnection Watcher:127.0.0.1:44801/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1562331 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1562331 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1562331 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1562333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1562333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1562333 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1562334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1562334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1562334 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1562335 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1562335 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1562335 INFO (zkCallback-1928-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1562336 INFO (zkCallback-1928-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> 1562336 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
[junit4] 2> 1562337 INFO (zkCallback-1928-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> 1562338 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44801 44801
[junit4] 2> 1562358 INFO (Thread-4145) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44801 44801
[junit4] 2> 1562359 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[CD161EE3B555190D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1562360 INFO (SUITE-ZkStateReaderTest-seed#[CD161EE3B555190D]-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/J1/temp/solr.cloud.overseer.ZkStateReaderTest_CD161EE3B555190D-001
[junit4] 2> Jul 05, 2016 3:21:08 PM 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=1591, maxMBSortInHeap=5.292035127524575, sim=ClassicSimilarity, locale=se-SE, timezone=Asia/Tashkent
[junit4] 2> NOTE: Linux 4.4.0-28-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=187099432,total=534249472
[junit4] 2> NOTE: All tests run in this JVM: [TermVectorComponentTest, TestReplicationHandlerBackup, SSLMigrationTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestStressUserVersions, CollectionReloadTest, TestQuerySenderListener, MinimalSchemaTest, TestLegacyFieldCache, TestAnalyzeInfixSuggestions, SuggesterFSTTest, CloneFieldUpdateProcessorFactoryTest, TestManagedSchemaAPI, TestCloudSchemaless, TestManagedStopFilterFactory, TestSearcherReuse, ReplicationFactorTest, HttpPartitionTest, DocumentBuilderTest, TestGraphMLResponseWriter, HdfsLockFactoryTest, TestTrie, SolrInfoMBeanTest, TestAuthenticationFramework, DistributedTermsComponentTest, AliasIntegrationTest, TestPartialUpdateDeduplication, SolrCmdDistributorTest, TestLMJelinekMercerSimilarityFactory, DistributedFacetPivotWhiteBoxTest, TestQueryUtils, BlockJoinFacetRandomTest, CollectionsAPIAsyncDistributedZkTest, TestSolrDynamicMBean, TestCollapseQParserPlugin, DeleteReplicaTest, OpenCloseCoreStressTest, TestUseDocValuesAsStored2, DistanceFunctionTest, TestSchemaSimilarityResource, TestHashQParserPlugin, TestSurroundQueryParser, SolrPluginUtilsTest, TestSystemIdResolver, DistribCursorPagingTest, SpellPossibilityIteratorTest, TestMacros, TestInfoStreamLogging, TestExpandComponent, TermsComponentTest, TestRandomRequestDistribution, DistributedMLTComponentTest, DistributedIntervalFacetingTest, HLLSerializationTest, SpatialFilterTest, FastVectorHighlighterTest, WrapperMergePolicyFactoryTest, ConfigSetsAPITest, TestDocumentBuilder, OverseerTaskQueueTest, TestStressVersions, TestDefaultSearchFieldResource, DOMUtilTest, TestUninvertingReader, UpdateRequestProcessorFactoryTest, TestFiltering, SimplePostToolTest, UniqFieldsUpdateProcessorFactoryTest, TestFieldTypeResource, TestCoreContainer, TestQuerySenderNoQuery, CachingDirectoryFactoryTest, SortByFunctionTest, ParsingFieldUpdateProcessorsTest, TestBinaryResponseWriter, ClusterStateUpdateTest, HdfsDirectoryFactoryTest, BooleanFieldTest, SuggestComponentContextFilterQueryTest, ZkStateWriterTest, TestSolrCoreProperties, TestBM25SimilarityFactory, TestFieldCacheSortRandom, TestEmbeddedSolrServerConstructors, TestDFRSimilarityFactory, TestLRUStatsCache, HdfsNNFailoverTest, ChaosMonkeySafeLeaderTest, TestFieldCacheReopen, TestFieldCollectionResource, TestReRankQParserPlugin, TestManagedResource, TestAuthorizationFramework, TestSimpleTrackingShardHandler, HdfsRestartWhileUpdatingTest, TestSolrQueryResponse, TestFieldSortValues, TestExceedMaxTermLength, TestDistribIDF, LeaderInitiatedRecoveryOnShardRestartTest, CollectionsAPIDistributedZkTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, ShardRoutingCustomTest, TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest, TestRealTimeGet, HardAutoCommitTest, StatsComponentTest, QueryElevationComponentTest, PeerSyncTest, ConvertedLegacyTest, TestFunctionQuery, BasicFunctionalityTest, TestLazyCores, TestBadConfig, HighlighterTest, SoftAutoCommitTest, SuggesterTSTTest, SuggesterTest, TestStressLucene, TestCSVLoader, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestUpdate, TestWordDelimiterFilterFactory, DefaultValueUpdateProcessorTest, TestRemoteStreaming, DocValuesMultiTest, XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, XmlUpdateRequestHandlerTest, TestValueSourceCache, TestIndexingPerformance, FieldAnalysisRequestHandlerTest, TestJmxIntegration, TestCSVResponseWriter, MBeansHandlerTest, JsonLoaderTest, CSVRequestHandlerTest, TestComponentsName, TestLFUCache, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CloudExitableDirectoryReaderTest, CollectionStateFormat2Test, ConnectionManagerTest, CustomCollectionTest, MultiThreadedOCPTest, RestartWhileUpdatingTest, RollingRestartTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SolrCLIZkUtilsTest, TestCloudBackupRestore, TestCloudInspectUtil, TestCollectionAPI, TestExclusionRuleCollectionAccess, TestOnReconnectListenerSupport, TestRequestForwarding, TestRequestStatusCollectionAPI, TestSizeLimitedDistributedMap, TestStressCloudBlindAtomicUpdates, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest, HdfsRecoverLeaseTest, HdfsRecoveryZkTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, ZkStateReaderTest]
[junit4] Completed [504/619 (1!)] on J1 in 2.41s, 6 tests, 2 errors <<< FAILURES!
[...truncated 378 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, 2 errors, 116 ignored (69 assumptions) [seed: CD161EE3B555190D]
Total time: 52 minutes 52 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