Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/320/
1 tests failed.
FAILED:
org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched
Error Message:
Stack Trace:
java.lang.NullPointerException
at
__randomizedtesting.SeedInfo.seed([426E97925D41014C:49D566BE0C18F7E5]: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 11416 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_426E97925D41014C-001/init-core-data-001
[junit4] 2> 896946 INFO
(SUITE-ZkStateReaderTest-seed#[426E97925D41014C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 896956 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 896957 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 896962 INFO (Thread-2674) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 896962 INFO (Thread-2674) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 897059 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:48479
[junit4] 2> 897060 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897072 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897086 INFO (zkCallback-1238-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3f984a23
name:ZooKeeperConnection Watcher:127.0.0.1:48479 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897086 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897086 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897096 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897098 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897099 INFO (zkCallback-1239-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@35c61e08
name:ZooKeeperConnection Watcher:127.0.0.1:48479 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897099 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897099 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897099 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 897104 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897106 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897106 INFO (zkCallback-1240-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@63603c32
name:ZooKeeperConnection Watcher:127.0.0.1:48479/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897106 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897106 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897107 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 897108 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 897109 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 897110 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 897112 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 897112 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 897113 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 897114 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 897119 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 897122 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 897126 INFO (zkCallback-1240-thread-2) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 897126 WARN (zkCallback-1240-thread-2) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /collections]
[junit4] 2> 897127 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48479 48479
[junit4] 2> 897246 INFO (Thread-2674) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:48479 48479
[junit4] 2> 897247 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest
-Dtests.method=testExternalCollectionWatchedNotWatched
-Dtests.seed=426E97925D41014C -Dtests.multiplier=2 -Dtests.slow=true
-Dtests.locale=zh-CN -Dtests.timezone=Australia/Perth -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.30s J2 |
ZkStateReaderTest.testExternalCollectionWatchedNotWatched <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at
__randomizedtesting.SeedInfo.seed([426E97925D41014C:49D566BE0C18F7E5]:0)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testExternalCollectionWatchedNotWatched(ZkStateReaderTest.java:167)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 897254 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 897255 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 897268 INFO (Thread-2675) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 897269 INFO (Thread-2675) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 897368 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:59877
[junit4] 2> 897369 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897373 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897390 INFO (zkCallback-1242-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@17e248e7
name:ZooKeeperConnection Watcher:127.0.0.1:59877 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897390 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897390 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897392 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897394 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897396 INFO (zkCallback-1243-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6339dfad
name:ZooKeeperConnection Watcher:127.0.0.1:59877 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897396 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897396 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897396 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 897401 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897402 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897413 INFO (zkCallback-1244-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@53377fb0
name:ZooKeeperConnection Watcher:127.0.0.1:59877/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897414 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897414 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897420 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 897429 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 897450 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 897465 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 897470 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 897471 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 897471 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 897472 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 897473 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 897474 INFO (zkCallback-1244-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 897481 INFO (zkCallback-1244-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> 897481 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 897482 INFO (zkCallback-1244-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> 897485 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59877 59877
[junit4] 2> 897659 INFO (Thread-2675) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:59877 59877
[junit4] 2> 897660 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 897662 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 897663 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 897671 INFO (Thread-2676) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 897671 INFO (Thread-2676) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 897771 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:36066
[junit4] 2> 897771 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897781 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897783 INFO (zkCallback-1246-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@61ed639e
name:ZooKeeperConnection Watcher:127.0.0.1:36066 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897784 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897784 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897785 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897786 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897788 INFO (zkCallback-1247-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7e233465
name:ZooKeeperConnection Watcher:127.0.0.1:36066 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897788 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 897802 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 897819 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 897832 INFO (zkCallback-1248-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@29e139e1
name:ZooKeeperConnection Watcher:127.0.0.1:36066/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 897832 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 897833 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 897834 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 897835 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 897836 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 897838 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 897838 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 897839 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 897840 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 897840 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 897842 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 897849 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 897850 INFO (zkCallback-1248-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 897863 INFO (zkCallback-1248-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> 897866 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 897866 INFO (zkCallback-1248-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> 897867 INFO (zkCallback-1248-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> 897867 INFO (zkCallback-1248-thread-2) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 897870 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36066 36066
[junit4] 2> 897971 INFO (Thread-2676) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:36066 36066
[junit4] 2> 897972 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 897974 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 897974 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 897975 INFO (Thread-2677) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 897975 INFO (Thread-2677) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 898075 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:38985
[junit4] 2> 898075 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898090 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898092 INFO (zkCallback-1250-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7bc1f21d
name:ZooKeeperConnection Watcher:127.0.0.1:38985 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898092 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898092 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898093 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898098 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898102 INFO (zkCallback-1251-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@65e71d4d
name:ZooKeeperConnection Watcher:127.0.0.1:38985 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898102 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898103 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898103 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 898105 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898107 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898107 INFO (zkCallback-1252-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@61f77843
name:ZooKeeperConnection Watcher:127.0.0.1:38985/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898107 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898108 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898109 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 898112 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 898113 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 898114 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 898115 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 898116 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 898116 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 898117 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 898120 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 898120 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 898121 INFO (zkCallback-1252-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 898124 INFO (zkCallback-1252-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> 898128 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 898129 INFO (zkCallback-1252-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> 898129 INFO (zkCallback-1252-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 898129 INFO (zkCallback-1252-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> 898143 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38985 38985
[junit4] 2> 898315 INFO (Thread-2677) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:38985 38985
[junit4] 2> 898315 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 898317 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 898318 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 898318 INFO (Thread-2678) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 898318 INFO (Thread-2678) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 898418 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:50353
[junit4] 2> 898418 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898420 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898427 INFO (zkCallback-1254-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@596f6e1e
name:ZooKeeperConnection Watcher:127.0.0.1:50353 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898428 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898428 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898429 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898430 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898430 INFO (zkCallback-1255-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@28b6baa7
name:ZooKeeperConnection Watcher:127.0.0.1:50353 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898430 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898431 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898431 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 898433 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898434 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898434 INFO (zkCallback-1256-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@34977605
name:ZooKeeperConnection Watcher:127.0.0.1:50353/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898434 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898435 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898435 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 898436 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 898437 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 898438 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 898439 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 898439 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 898440 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 898441 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 898442 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 898444 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 898444 INFO (zkCallback-1256-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> 898445 INFO (zkCallback-1256-thread-2) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 898453 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 898454 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 898454 INFO (zkCallback-1256-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> 898458 INFO (zkCallback-1256-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> 898462 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50353 50353
[junit4] 2> 898630 INFO (Thread-2678) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:50353 50353
[junit4] 2> 898632 WARN (Thread-2678) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/collections/c1/state.json
[junit4] 2>
[junit4] 2> 898634 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 898636 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 898636 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 898636 INFO (Thread-2679) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 898637 INFO (Thread-2679) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 898737 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer start zk server on port:34763
[junit4] 2> 898737 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898737 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898739 INFO (zkCallback-1258-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5788331a
name:ZooKeeperConnection Watcher:127.0.0.1:34763 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898739 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898740 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898741 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 0x155c2a9b7770000, 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> 898741 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898742 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898742 INFO (zkCallback-1259-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4ca813e6
name:ZooKeeperConnection Watcher:127.0.0.1:34763 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898742 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898742 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898742 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 898746 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 898746 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 898747 INFO (zkCallback-1260-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6961ff8b
name:ZooKeeperConnection Watcher:127.0.0.1:34763/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 898747 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 898747 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 898747 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 898749 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 898750 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 898751 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 898755 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 898756 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 898756 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 898757 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 898759 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 898759 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 898760 INFO (zkCallback-1260-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 898762 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 898762 INFO (zkCallback-1260-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> 898763 INFO (zkCallback-1260-thread-1) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 898765 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34763 34763
[junit4] 2> 898933 INFO (Thread-2679) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:34763 34763
[junit4] 2> 898935 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[426E97925D41014C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 898935 INFO
(SUITE-ZkStateReaderTest-seed#[426E97925D41014C]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_426E97925D41014C-001
[junit4] 2> Jul 07, 2016 12:02:30 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=210, maxMBSortInHeap=7.675925929462168,
sim=ClassicSimilarity, locale=zh-CN, timezone=Australia/Perth
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_74 (64-bit)/cpus=4,threads=1,free=149544464,total=521666560
[junit4] 2> NOTE: All tests run in this JVM: [TestCustomSort,
DebugComponentTest, TestDistributedStatsComponentCardinality, TestCharFilters,
AnalyticsQueryTest, DirectUpdateHandlerOptimizeTest, ClusterStateTest,
TestOverriddenPrefixQueryForCustomFieldType, CoreMergeIndexesAdminHandlerTest,
DirectUpdateHandlerTest, GraphQueryTest, TestIndexSearcher, BlockCacheTest,
TestSolrIndexConfig, TestFieldTypeCollectionResource,
TestDistributedMissingSort, TestDynamicFieldResource,
TestImplicitCoreProperties, SpatialRPTFieldTypeTest, UpdateParamsTest,
CircularListTest, DirectSolrConnectionTest, LeaderFailoverAfterPartitionTest,
TestElisionMultitermQuery, TestTolerantUpdateProcessorCloud,
TestFieldCacheSort, CoreAdminHandlerTest, TestTrackingShardHandlerFactory,
TestReversedWildcardFilterFactory, TestStressReorder,
TestPostingsSolrHighlighter, TestXIncludeConfig, TestWriterPerf,
TestPHPSerializedResponseWriter, HighlighterConfigTest,
TermVectorComponentDistributedTest, TestRawTransformer, TestSchemaResource,
SegmentsInfoRequestHandlerTest, BaseCdcrDistributedZkTest, CleanupOldIndexTest,
TestSubQueryTransformerDistrib, TestDefaultStatsCache, TestIntervalFaceting,
CollectionStateFormat2Test, TestUniqueKeyFieldResource, TestSolrConfigHandler,
ConnectionManagerTest, HdfsDirectoryTest, TestFuzzyAnalyzedSuggestions,
LukeRequestHandlerTest, TestJmxIntegration, TestJettySolrRunner,
RequestHandlersTest, TestNamedUpdateProcessors,
StatelessScriptUpdateProcessorFactoryTest, TriLevelCompositeIdRoutingTest,
RestartWhileUpdatingTest, SolrCloudExampleTest, TestCollationField,
SpatialHeatmapFacetsTest, TestFieldCacheWithThreads, BadIndexSchemaTest,
UnloadDistributedZkTest, VersionInfoTest, TestSerializedLuceneMatchVersion,
DistributedFacetPivotLargeTest, TestMiniSolrCloudClusterBase,
TestFileDictionaryLookup, CdcrRequestHandlerTest, TestBackupRepositoryFactory,
RuleEngineTest, RequestLoggingTest, HardAutoCommitTest, PrimitiveFieldTypeTest,
TestDistribDocBasedVersion, LeaderElectionTest, TestSolrDeletionPolicy1,
DistanceUnitsTest, HdfsWriteToMultipleCollectionsTest, TestChildDocTransformer,
SearchHandlerTest, TestRecovery, QueryParsingTest,
ConjunctionSolrSpellCheckerTest, SharedFSAutoReplicaFailoverUtilsTest,
HdfsThreadLeakTest, BadComponentTest, TestSolrCloudWithKerberosAlt,
NoCacheHeaderTest, TestSuggestSpellingConverter, TestCSVResponseWriter,
SuggesterWFSTTest, AnalysisErrorHandlingTest, FullHLLTest,
HdfsBasicDistributedZkTest, ZkStateReaderTest]
[junit4] Completed [255/621 (1!)] on J2 in 2.51s, 6 tests, 1 error <<<
FAILURES!
[...truncated 1236 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:740: The
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:684: The
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/build.xml:59: The
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/common-build.xml:530:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:1427:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/lucene/common-build.xml:984:
There were test failures: 621 suites (10 ignored), 2642 tests, 1 error, 103
ignored (88 assumptions) [seed: 426E97925D41014C]
Total time: 82 minutes 36 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]