Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.5/31/
2 tests failed.
FAILED:
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh
Error Message:
Could not find collection : c1
Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
at
__randomizedtesting.SeedInfo.seed([1FFB2C4CAFE43EF6:415DBB7F84F833]:0)
at
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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)
FAILED:
org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchOnMasterRestart
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([1FFB2C4CAFE43EF6:C70CE8A8043FFCAA]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchOnMasterRestart(TestReplicationHandler.java:625)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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 11275 lines...]
[junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_1FFB2C4CAFE43EF6-001/init-core-data-001
[junit4] 2> 1532820 INFO
(SUITE-ZkStateReaderTest-seed#[1FFB2C4CAFE43EF6]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1532822 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1532822 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1532835 INFO (Thread-1165) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1532835 INFO (Thread-1165) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1532941 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:39936
[junit4] 2> 1532941 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1532963 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1532964 INFO (zkCallback-17032-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2f2fc9bd
name:ZooKeeperConnection Watcher:127.0.0.1:39936 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1532965 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1532965 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1532978 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 0x15f2f4636390000, 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> 1532978 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1533006 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1533006 INFO (zkCallback-17033-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1b226789
name:ZooKeeperConnection Watcher:127.0.0.1:39936 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1533006 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1533007 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1533007 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1533023 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1533024 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1533024 INFO (zkCallback-17034-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6c3a5a77
name:ZooKeeperConnection Watcher:127.0.0.1:39936/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1533024 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1533024 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1533025 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1533025 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1533042 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1533043 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1533044 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1533044 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1533045 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1533046 INFO (zkCallback-17034-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1533081 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1533091 INFO (zkCallback-17034-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> 1534614 WARN (zkCallback-17034-thread-2) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 1534615 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39936 39936
[junit4] 2> 1534760 INFO (Thread-1165) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:39936 39936
[junit4] 2> 1534761 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testStateFormatUpdateWithExplicitRefreshLazy
[junit4] 2> 1534763 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
[junit4] 2> 1534763 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1534763 INFO (Thread-1166) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1534763 INFO (Thread-1166) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1534869 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:46069
[junit4] 2> 1534869 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1534926 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1534979 INFO (zkCallback-17035-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@281e7bfc
name:ZooKeeperConnection Watcher:127.0.0.1:46069 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1534979 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1534979 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535003 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1535023 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1535035 INFO (zkCallback-17036-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1945f073
name:ZooKeeperConnection Watcher:127.0.0.1:46069 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1535035 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1535036 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535036 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1535052 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1535072 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1535072 INFO (zkCallback-17037-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3b8885ae
name:ZooKeeperConnection Watcher:127.0.0.1:46069/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1535072 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1535072 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535073 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1535073 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1535074 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1535075 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1535075 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1535076 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1535089 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1535090 INFO (zkCallback-17037-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1535090 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1535091 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1535091 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1535091 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
[junit4] 2> 1535186 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46069 46069
[junit4] 2> 1535474 INFO (Thread-1166) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:46069 46069
[junit4] 2> 1535475 INFO
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
[junit4] 2> 1535477 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
[junit4] 2> 1535477 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1535494 INFO (Thread-1167) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1535494 INFO (Thread-1167) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1535603 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:43092
[junit4] 2> 1535603 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1535620 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1535676 INFO (zkCallback-17038-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@75c39463
name:ZooKeeperConnection Watcher:127.0.0.1:43092 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1535676 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1535676 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535693 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1535729 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1535761 INFO (zkCallback-17039-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6f36b430
name:ZooKeeperConnection Watcher:127.0.0.1:43092 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1535765 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1535765 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535765 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1535785 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1535804 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1535818 INFO (zkCallback-17040-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@322cf8b9
name:ZooKeeperConnection Watcher:127.0.0.1:43092/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1535818 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1535818 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1535818 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1535819 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1535820 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1535820 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1535821 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1535822 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1535855 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1535855 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1535856 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1535856 INFO (zkCallback-17040-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1535857 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1535927 INFO (zkCallback-17040-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> 1535929 INFO (zkCallback-17040-thread-2) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1535985 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43092 43092
[junit4] 2> 1536220 INFO (Thread-1167) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:43092 43092
[junit4] 2> 1536221 INFO
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
[junit4] 2> 1536223 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1536239 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1536244 INFO (Thread-1168) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1536244 INFO (Thread-1168) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1536244 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:36116
[junit4] 2> 1536244 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536245 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536308 INFO (zkCallback-17041-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@41a00d16
name:ZooKeeperConnection Watcher:127.0.0.1:36116 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536309 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536309 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536336 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 0x15f2f4643750000, 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> 1536356 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536356 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536393 INFO (zkCallback-17042-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3a0a2f9b
name:ZooKeeperConnection Watcher:127.0.0.1:36116 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536393 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536393 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536393 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1536450 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536454 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536454 INFO (zkCallback-17043-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@17eae349
name:ZooKeeperConnection Watcher:127.0.0.1:36116/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536454 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536455 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536455 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1536458 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1536475 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1536476 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1536477 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1536478 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1536491 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1536492 INFO (zkCallback-17043-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1536493 INFO (zkCallback-17043-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> 1536494 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1536494 INFO (zkCallback-17043-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> 1536527 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36116 36116
[junit4] 2> 1536605 INFO (Thread-1168) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:36116 36116
[junit4] 2> 1536606 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
[junit4] 2> 1536608 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testStateFormatUpdateWithExplicitRefresh
[junit4] 2> 1536641 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1536641 INFO (Thread-1169) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1536641 INFO (Thread-1169) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1536746 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:42771
[junit4] 2> 1536746 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536767 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536768 INFO (zkCallback-17044-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1e036da1
name:ZooKeeperConnection Watcher:127.0.0.1:42771 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536768 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536769 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536769 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 0x15f2f4645060000, 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> 1536769 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536770 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536770 INFO (zkCallback-17045-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@32c52502
name:ZooKeeperConnection Watcher:127.0.0.1:42771 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536770 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536771 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536771 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1536786 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1536823 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1536823 INFO (zkCallback-17046-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@331f4897
name:ZooKeeperConnection Watcher:127.0.0.1:42771/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1536823 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1536823 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1536831 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1536832 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1536833 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1536834 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1536834 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1536835 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1536925 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1536926 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1536926 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1536928 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1536932 INFO (zkCallback-17046-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1536945 INFO (zkCallback-17046-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> 1536965 INFO (zkCallback-17046-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for
collection [c1] has occurred - updating... (live nodes size: [0])
[junit4] 2> 1536965 WARN (zkCallback-17046-thread-3) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /collections/c1/state.json]
[junit4] 2> 1536998 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42771 42771
[junit4] 2> 1537228 INFO (Thread-1169) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:42771 42771
[junit4] 2> 1537236 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest
-Dtests.method=testStateFormatUpdateWithExplicitRefresh
-Dtests.seed=1FFB2C4CAFE43EF6 -Dtests.multiplier=2 -Dtests.slow=true
-Dtests.locale=fr-CA -Dtests.timezone=America/Argentina/San_Juan
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.63s J0 |
ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not
find collection : c1
[junit4] > at
__randomizedtesting.SeedInfo.seed([1FFB2C4CAFE43EF6:415DBB7F84F833]:0)
[junit4] > at
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
[junit4] > at
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1537240 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
[junit4] 2> 1537253 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1537260 INFO (Thread-1170) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1537260 INFO (Thread-1170) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1537370 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer start zk server on port:39106
[junit4] 2> 1537370 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1537387 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1537548 INFO (zkCallback-17047-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6348fa1f
name:ZooKeeperConnection Watcher:127.0.0.1:39106 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1537549 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1537549 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1537550 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1537605 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1537633 INFO (zkCallback-17048-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7342977e
name:ZooKeeperConnection Watcher:127.0.0.1:39106 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1537634 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1537634 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1537634 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1537658 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1537690 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1537718 INFO (zkCallback-17049-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4cf7bbab
name:ZooKeeperConnection Watcher:127.0.0.1:39106/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1537720 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1537720 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1537721 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1537721 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1537722 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1537755 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1537756 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1537757 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1537758 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
[junit4] 2> 1537758 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
[junit4] 2> 1537758 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1537800 INFO (zkCallback-17049-thread-1) [ ]
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1537877 INFO (zkCallback-17049-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> 1537938 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/c1/state.json
[junit4] 2> 1537945 INFO (zkCallback-17049-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> 1537946 INFO (zkCallback-17049-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> 1537966 INFO (zkCallback-17049-thread-2) [ ]
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
[junit4] 2> 1538003 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39106 39106
[junit4] 2> 1538079 INFO (Thread-1170) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:39106 39106
[junit4] 2> 1538080 INFO
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
[junit4] 2> 1538080 INFO
(SUITE-ZkStateReaderTest-seed#[1FFB2C4CAFE43EF6]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_1FFB2C4CAFE43EF6-001
[junit4] 2> Oct 18, 2017 11:37:36 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene54, sim=DefaultSimilarity,
locale=fr-CA, timezone=America/Argentina/San_Juan
[junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 1.7.0_80
(64-bit)/cpus=4,threads=1,free=201194792,total=340787200
[junit4] 2> NOTE: All tests run in this JVM: [TestCrossCoreJoin,
TestRemoteStreaming, TestImplicitCoreProperties, URLClassifyProcessorTest,
ActionThrottleTest, TestCollationFieldDocValues,
UUIDUpdateProcessorFallbackTest, CollectionStateFormat2Test,
RequiredFieldsTest, TestMergePolicyConfig, JsonLoaderTest,
TestClassNameShortening, TestStressLiveNodes, TestRebalanceLeaders,
TestComplexPhraseQParserPlugin, TestPseudoReturnFields, TestCryptoKeys,
HdfsBasicDistributedZk2Test, OutputWriterTest, UUIDFieldTest,
QueryEqualityTest, TestSolr4Spatial, RequestLoggingTest, TestConfigSetsAPI,
TestConfig, DeleteShardTest, TestMiniSolrCloudCluster, OverseerStatusTest,
MergeStrategyTest, CoreAdminRequestStatusTest,
OverriddenZkACLAndCredentialsProvidersTest, RecoveryAfterSoftCommitTest,
TestLRUCache, CacheHeaderTest, PathHierarchyTokenizerFactoryTest,
TestRemoveLastDynamicCopyField, TestSchemaSimilarityResource,
SharedFSAutoReplicaFailoverUtilsTest, TestRTimerTree, TestConfigSetProperties,
ResourceLoaderTest, ZkStateReaderTest]
[junit4] Completed [203/575 (1!)] on J0 in 5.71s, 6 tests, 1 error <<<
FAILURES!
[...truncated 318 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/init-core-data-001
[junit4] 2> 2886047 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
[junit4] 2> 2886047 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1
[junit4] 2> 2886077 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 2886078 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@16b38a56{/solr,null,AVAILABLE}
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@653f1fbe{HTTP/1.1}{127.0.0.1:45520}
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.Server Started @2897536ms
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1/data,
hostPort=45520}
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4f6de641
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001'
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 2886079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/solr.xml
[junit4] 2> 2886122 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/.
[junit4] 2> 2886122 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer New CoreContainer 1099539433
[junit4] 2> 2886122 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001]
[junit4] 2> 2886122 WARN
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/lib
to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/lib
[junit4] 2> 2886122 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries :
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 2886127 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2886134 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2886134 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2886134 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 2886134 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2886135 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/.
[junit4] 2> 2886136 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreDescriptor Created CoreDescriptor: {transient=false, dataDir=data/,
name=collection1, schema=schema.xml, configSetProperties=configsetprops.json,
config=solrconfig.xml, loadOnStartup=true}
[junit4] 2> 2886136 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Found core collection1 in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1
[junit4] 2> 2886136 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2886154 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1'
[junit4] 2> 2886173 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2886173 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 2886167 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter
user.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2
[junit4] 2> 2886191 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 2886213 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2886244 WARN (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 2886246 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.4
[junit4] 2> 2886318 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2886338 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2886355 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1'
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data/]
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
collection1
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data
[junit4] 2> 2886356 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data/index/
[junit4] 2> 2886357 WARN (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 2886357 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data/index
[junit4] 2> 2886357 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=44, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=16.7373046875,
floorSegmentMB=0.7265625, forceMergeDeletesPctAllowed=12.090422227871283,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2886374 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@45b215b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aeadf98),segFN=segments_1,generation=1}
[junit4] 2> 2886374 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2886384 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 2886386 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886387 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886387 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886388 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886389 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
startup=lazy
[junit4] 2> 2886389 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/properties,/update/json/docs,/update/json,lazy,/get,/update/csv,/admin/logging,/update,/schema,standard,/admin/file,/config,/admin/ping,/admin/plugins,/admin/segments,/admin/mbeans,defaults,/admin/system,/replication,/admin/threads,/admin/luke
[junit4] 2> 2886406 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/./collection1/data/
[junit4] 2> 2886463 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@45b215b
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7aeadf98),segFN=segments_1,generation=1}
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7e9bd361[collection1]
main
[junit4] 2> 2886475 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1/conf
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1/conf}
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-001/collection1/conf
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2886476 INFO
(searcherExecutor-3294-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7e9bd361[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2886476 INFO (coreLoadExecutor-3293-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2886692 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1
[junit4] 2> 2886695 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7982e52f{/solr,null,AVAILABLE}
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@216c22b0{HTTP/1.1}{127.0.0.1:43405}
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.e.j.s.Server Started @2898153ms
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1/data,
hostPort=43405, hostContext=/solr}
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4f6de641
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002'
[junit4] 2> 2886696 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2886697 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 2886697 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/solr.xml
[junit4] 2> 2886726 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/.
[junit4] 2> 2886726 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer New CoreContainer 2001285730
[junit4] 2> 2886726 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002]
[junit4] 2> 2886726 WARN
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/lib
to classpath:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/lib
[junit4] 2> 2886739 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries :
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 2886739 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2886740 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2886740 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2886740 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 2886740 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2886740 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/.
[junit4] 2> 2886741 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CoreDescriptor Created CoreDescriptor:
{configSetProperties=configsetprops.json, config=solrconfig.xml,
transient=false, schema=schema.xml, dataDir=data/, loadOnStartup=true,
name=collection1}
[junit4] 2> 2886741 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Found core collection1 in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1
[junit4] 2> 2886741 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2886742 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1'
[junit4] 2> 2886742 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2886742 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 2886755 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter
user.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2
[junit4] 2> 2886755 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[1FFB2C4CAFE43EF6]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 2886756 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2886846 WARN (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 2886848 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.4
[junit4] 2> 2886907 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2886918 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2886934 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1'
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data/]
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
collection1
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data
[junit4] 2> 2886936 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data/index/
[junit4] 2> 2886936 WARN (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 2886937 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data/index
[junit4] 2> 2886937 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=44, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=16.7373046875,
floorSegmentMB=0.7265625, forceMergeDeletesPctAllowed=12.090422227871283,
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2886937 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ee0a09
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@20d50820),segFN=segments_1,generation=1}
[junit4] 2> 2886937 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2886946 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/./collection1/data/
[junit4] 2> 2886949 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 2886951 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886952 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886952 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886953 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2886970 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
startup=lazy
[junit4] 2> 2886970 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/properties,/update/json/docs,/update/json,lazy,/get,/update/csv,/admin/logging,/update,/schema,standard,/admin/file,/config,/admin/ping,/admin/plugins,/admin/segments,/admin/mbeans,defaults,/admin/system,/replication,/admin/threads,/admin/luke
[junit4] 2> 2886971 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2886971 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2886971 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2886971 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@63ee0a09
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@20d50820),segFN=segments_1,generation=1}
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2feb8bac[collection1]
main
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1/conf
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageDir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1/conf}
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
file:dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-002/collection1/conf
[junit4] 2> 2886972 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2886974 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
1000ms
[junit4] 2> 2886974 INFO (coreLoadExecutor-3303-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2886974 INFO
(searcherExecutor-3304-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2feb8bac[collection1] main{ExitableDirectoryReader(Un
[...truncated too long message...]
test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data/index
[CachedDir<<refCount=0;path=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data/index;done=false>>]
[junit4] 2> 3022682 INFO (coreCloseExecutor-4002-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data/index
[junit4] 2> 3022682 INFO (coreCloseExecutor-4002-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data
[CachedDir<<refCount=0;path=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data;done=false>>]
[junit4] 2> 3022682 INFO (coreCloseExecutor-4002-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-033/collection1/data
[junit4] 2> 3022682 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1FFB2C4CAFE43EF6])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@8919001{/solr,null,UNAVAILABLE}
[junit4] 2> 3022730 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1FFB2C4CAFE43EF6])
[ ] o.e.j.s.ServerConnector Stopped
ServerConnector@5f9098e3{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 3022730 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1FFB2C4CAFE43EF6])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1169411496
[junit4] 2> 3022738 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1baee2
[junit4] 2> 3022738 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=0,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 3022739 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 3022739 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 3022739 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 3022740 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 3022741 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing
NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 3022741 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data/index
[CachedDir<<refCount=0;path=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data/index;done=false>>]
[junit4] 2> 3022741 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data/index
[junit4] 2> 3022741 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data
[CachedDir<<refCount=0;path=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data;done=false>>]
[junit4] 2> 3022741 INFO (coreCloseExecutor-4004-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001/solr-instance-034/collection1/data
[junit4] 2> 3022741 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1FFB2C4CAFE43EF6])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@13a66522{/solr,null,UNAVAILABLE}
[junit4] 2> 3022742 INFO
(SUITE-TestReplicationHandler-seed#[1FFB2C4CAFE43EF6]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_1FFB2C4CAFE43EF6-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene54):
{id=FSTOrd50, newname=FSTOrd50, name=FSTOrd50}, docValues:{},
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=cs-CZ,
timezone=America/Halifax
[junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 1.7.0_80
(64-bit)/cpus=4,threads=1,free=199789800,total=484966400
[junit4] 2> NOTE: All tests run in this JVM: [StatsComponentTest,
TestZkChroot, QueryParsingTest, TestRandomRequestDistribution, TestRestoreCore,
OverseerTest, SimpleFacetsTest, SuggesterWFSTTest,
StatelessScriptUpdateProcessorFactoryTest, TestSearcherReuse, TestReload,
TestMinMaxOnMultiValuedField, RegexBoostProcessorTest, RequestHandlersTest,
DataDrivenBlockJoinTest, CircularListTest,
OutOfBoxZkACLAndCredentialsProvidersTest, TestTolerantSearch,
TestElisionMultitermQuery, TestSuggestSpellingConverter, HardAutoCommitTest,
TestSweetSpotSimilarityFactory, NoCacheHeaderTest,
LeaderInitiatedRecoveryOnShardRestartTest, TestReRankQParserPlugin,
DocValuesMissingTest, CoreSorterTest, TestExtendedDismaxParser,
DistributedFacetPivotLongTailTest, TestJmxMonitoredMap, TestJettySolrRunner,
TestNamedUpdateProcessors, TestShardHandlerFactory, TestFreeTextSuggestions,
DistribCursorPagingTest, ShowFileRequestHandlerTest, TestMaxScoreQueryParser,
TestGroupingSearch, BadCopyFieldTest, TestSolrXml, TestDynamicLoading,
TestSolrDeletionPolicy1, SliceStateTest, TestClusterStateMutator,
DistributedDebugComponentTest, TestManagedSchemaAPI,
SharedFSAutoReplicaFailoverTest, FullSolrCloudDistribCmdsTest,
TestDefaultSearchFieldResource, ScriptEngineTest, TestCollapseQParserPlugin,
TestSort, TestLRUStatsCache, TestUniqueKeyFieldResource, TestJsonRequest,
TestTestInjection, TestObjectReleaseTracker, TestSolr4Spatial2,
CoreAdminHandlerTest, TestSerializedLuceneMatchVersion, BadIndexSchemaTest,
TestSolrQueryParser, CurrencyFieldXmlFileTest, TestUtils,
TestConfigSetImmutable, RuleEngineTest, CollectionReloadTest,
TestSolrIndexConfig, BadComponentTest, TestPerFieldSimilarity,
HdfsUnloadDistributedZkTest, SampleTest, HLLSerializationTest,
PrimitiveFieldTypeTest, DirectUpdateHandlerOptimizeTest,
TestPerFieldSimilarityWithDefaultOverride, DirectSolrConnectionTest,
InfoHandlerTest, TestConfigSetsAPIZkFailure, TestSolrJ, TestInitParams,
TestPostingsSolrHighlighter, DirectUpdateHandlerTest, TestJmxIntegration,
TestCollectionAPI, TestCharFilters, TestDistribIDF, TestTrieFacet,
TestFieldCollectionResource, DocValuesMultiTest, TestBulkSchemaConcurrent,
TestFastWriter, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest,
UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest,
LeaderElectionIntegrationTest, RecoveryZkTest, TestReplicationHandler]
[junit4] Completed [291/575 (2!)] on J2 in 136.80s, 16 tests, 1 failure <<<
FAILURES!
[...truncated 919 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:750: The
following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:694: The
following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:59: The
following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build.xml:233:
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/common-build.xml:534:
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/lucene/common-build.xml:1477:
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/lucene/common-build.xml:1033:
There were test failures: 575 suites (7 ignored), 2329 tests, 1 error, 1
failure, 55 ignored (39 assumptions) [seed: 1FFB2C4CAFE43EF6]
Total time: 187 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[Fast Archiver] No prior successful build to compare, so performing full copy
of 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]
