Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/21/
2 tests failed.
FAILED: org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test
Error Message:
Exactly one shard should have changed, instead: [shard2, shard1]
nodes=([core_node3(shard2), core_node2(shard1), core_node4(shard1)])
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: Exactly one shard should have changed, instead:
[shard2, shard1] nodes=([core_node3(shard2), core_node2(shard1),
core_node4(shard1)]) expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([89084DC3E22E3B:88DD37976D1E43C3]: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.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test(DistribDocExpirationUpdateProcessorTest.java:118)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
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.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Thu Mar 24 08:02:17
CET 2016
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to
exceed: Thu Mar 24 08:02:17 CET 2016
at
__randomizedtesting.SeedInfo.seed([89084DC3E22E3B:DB22088BC6CA4788]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1422)
at
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:774)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11661 lines...]
[junit4] Suite: org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/init-core-data-001
[junit4] 2> 1325594 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[89084DC3E22E3B]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
[junit4] 2> 1325594 INFO
(SUITE-DistribDocExpirationUpdateProcessorTest-seed#[89084DC3E22E3B]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1325597 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1325598 INFO (Thread-11720) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1325598 INFO (Thread-11720) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1325698 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkTestServer start zk server on port:41242
[junit4] 2> 1325698 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1325698 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325700 INFO (zkCallback-1419-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@300fa29a
name:ZooKeeperConnection Watcher:127.0.0.1:41242 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1325700 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325701 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1325701 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1325703 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1325703 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325704 INFO (zkCallback-1420-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2a5aeb40
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1325704 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325704 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1325704 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 1325705 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 1325707 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 1325708 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 1325709 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-doc-expire-update-processor.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1325709 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1325711 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 1325711 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 1325713 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1325713 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1325715 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1325715 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1325716 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1325716 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 1325717 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1325717 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 1325719 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1325719 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 1325720 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1325720 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1325722 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1325722 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1325723 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1325723 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1325725 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1325725 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1325812 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1
[junit4] 2> 1325814 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1325815 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@60e252df{/,null,AVAILABLE}
[junit4] 2> 1325817 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.ServerConnector Started
ServerConnector@5f78e424{HTTP/1.1,[http/1.1]}{127.0.0.1:50594}
[junit4] 2> 1325817 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.Server Started @1328572ms
[junit4] 2> 1325817 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/tempDir-001/control/data,
hostContext=/, hostPort=50594,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores}
[junit4] 2> 1325818 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1325818 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001'
[junit4] 2> 1325818 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1325818 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1325818 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1325823 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325825 INFO (zkCallback-1421-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@222063af
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1325825 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325825 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1325826 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1325826 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/solr.xml
[junit4] 2> 1325831 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores
[junit4] 2> 1325831 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer New CoreContainer 552428901
[junit4] 2> 1325831 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001]
[junit4] 2> 1325831 WARN
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/lib
[junit4] 2> 1325832 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] 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,
[junit4] 2> 1325833 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1325834 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1325834 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1325834 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41242/solr
[junit4] 2> 1325834 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1325834 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1325835 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325836 INFO (zkCallback-1424-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1f66a291
name:ZooKeeperConnection Watcher:127.0.0.1:41242 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1325837 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325837 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1325839 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1325839 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3cfe7fe3
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1325839 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1325840 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1325842 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 1325844 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 1325846 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 1325847 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 1325849 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1325850 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1325851 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1325852 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1325853 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1325854 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 1325856 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1325857 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 1325858 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1325858 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/95604029526376452-127.0.0.1:50594_-n_0000000000
[junit4] 2> 1325859 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:50594_
[junit4] 2> 1325859 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1325860 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer Overseer
(id=95604029526376452-127.0.0.1:50594_-n_0000000000) starting
[junit4] 2> 1325861 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1325866 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1325866 INFO
(OverseerCollectionConfigSetProcessor-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 1325866 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1325867 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50594_
[junit4] 2> 1325868 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:50594_
[junit4] 2> 1325872 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 1325872 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [0])
[junit4] 2> 1325873 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1325889 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1325889 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1325890 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores
[junit4] 2> 1325890 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1325890 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1
[junit4] 2> 1325890 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1325891 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
[junit4] 2> 1325891 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:50594_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1325891 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1325892 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1325893 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50594";,
[junit4] 2> "node_name":"127.0.0.1:50594_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1325893 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50594";,
[junit4] 2> "node_name":"127.0.0.1:50594_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1325893 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 1325894 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 1325894 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 1325895 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 1326894 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 1326894 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 1326895 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 1326895 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 1326896 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 1326896 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1'
[junit4] 2> 1326896 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1326896 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1326898 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 1326903 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 1326906 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.1.0
[junit4] 2> 1326935 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1326940 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1327015 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 1327016 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 1327017 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1327019 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1327032 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
[junit4] 2> 1327032 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 1327032 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1327033 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/]
[junit4] 2> 1327033 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1327033 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data
[junit4] 2> 1327033 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/index/
[junit4] 2> 1327033 WARN
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 1327034 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/index
[junit4] 2> 1327034 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=8, maxMergeAtOnceExplicit=4, maxMergedSegmentMB=4.8896484375,
floorSegmentMB=0.8310546875, forceMergeDeletesPctAllowed=24.16925454222616,
segmentsPerTier=29.0, maxCFSSegmentSizeMB=0.560546875, noCFSRatio=1.0
[junit4] 2> 1327034 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5a91bdf9
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ab563ad),segFN=segments_1,generation=1}
[junit4] 2> 1327034 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1327036 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"convert-ttl-defaults"
[junit4] 2> 1327050 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/
[junit4] 2> 1327050 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 1327059 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"convert-ttl-field"
[junit4] 2> 1327060 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"convert-ttl-param"
[junit4] 2> 1327060 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"convert-ttl-field-with-param-default"
[junit4] 2> 1327060 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"scheduled-delete" (default)
[junit4] 2> 1327079 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"scheduled-delete" (default)
[junit4] 2> 1327081 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1327082 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1327083 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1327085 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1327087 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 1327087 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1327087 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1327087 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1327088 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1327088 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1327088 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=48, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=76.306640625,
floorSegmentMB=1.8828125, forceMergeDeletesPctAllowed=28.506955584445947,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1327095 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5a91bdf9
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ab563ad),segFN=segments_1,generation=1}
[junit4] 2> 1327095 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1327095 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@229c3cd5[collection1] main]
[junit4] 2> 1327095 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 1327097 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 1327097 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the
RestManager with znodeBase: /configs/conf1
[junit4] 2> 1327097 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1327097 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1327097 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1327098 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 1327098 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1327098 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1327116 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1327116 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1327116 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version
buckets from index
[junit4] 2> 1327116 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket
highest value from index
[junit4] 2> 1327116 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1529664474012712960
[junit4] 2> 1327116 INFO
(searcherExecutor-3380-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@229c3cd5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1327118 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version
1529664474012712960
[junit4] 2> 1327118 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 1327119 INFO
(coreLoadExecutor-3379-thread-1-processing-n:127.0.0.1:50594_)
[n:127.0.0.1:50594_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1327120 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:http://127.0.0.1:50594
collection:control_collection shard:shard1
[junit4] 2> 1327120 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1327124 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector
Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/95604029526376452-core_node1-n_0000000000
[junit4] 2> 1327124 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1
and weAreReplacement=false and leaderVoteWait=10000
[junit4] 2> 1327127 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 1327127 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1327127 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1327127 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:50594/collection1/
[junit4] 2> 1327127 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1327127 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:50594/collection1/ has no replicas
[junit4] 2> 1327129 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1327131 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/control_collection/leaders/shard1/leader after winning as
/collections/control_collection/leader_elect/shard1/election/95604029526376452-core_node1-n_0000000000
[junit4] 2> 1327132 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:50594/collection1/ shard1
[junit4] 2> 1327133 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:50594";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1327235 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 1327284 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:50594/collection1/ and leader is
http://127.0.0.1:50594/collection1/
[junit4] 2> 1327285 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:50594
[junit4] 2> 1327285 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 1327285 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 1327285 INFO
(coreZkRegister-3373-thread-1-processing-n:127.0.0.1:50594_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:50594_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1327290 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50594";,
[junit4] 2> "node_name":"127.0.0.1:50594_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1327291 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:50594";,
[junit4] 2> "node_name":"127.0.0.1:50594_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1327394 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1327396 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1327396 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 1327396 INFO (zkCallback-1427-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@615b8eac
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1327397 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1327397 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1327397 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1327399 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1327400 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 1327535 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores/collection1
[junit4] 2> 1327536 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001
[junit4] 2> 1327537 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1327538 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@746cfbce{/,null,AVAILABLE}
[junit4] 2> 1327538 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.ServerConnector Started
ServerConnector@6147460{HTTP/1.1,[http/1.1]}{127.0.0.1:46690}
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.e.j.s.Server Started @1330294ms
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=46690,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores}
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001'
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1327539 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1327543 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1327549 INFO (zkCallback-1428-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7ce3e4dc
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1327549 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1327550 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1327551 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1327551 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/solr.xml
[junit4] 2> 1327556 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores
[junit4] 2> 1327556 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer New CoreContainer 681816608
[junit4] 2> 1327556 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001]
[junit4] 2> 1327556 WARN
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/lib
[junit4] 2> 1327556 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] 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,
[junit4] 2> 1327557 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1327558 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1327558 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1327558 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41242/solr
[junit4] 2> 1327558 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1327558 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1327564 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1327564 INFO (zkCallback-1431-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@14861e4 name:ZooKeeperConnection
Watcher:127.0.0.1:41242 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1327565 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1327565 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1327567 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1327568 INFO
(zkCallback-1432-thread-1-processing-n:127.0.0.1:46690_) [n:127.0.0.1:46690_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@10d7f0fb
name:ZooKeeperConnection Watcher:127.0.0.1:41242/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1327568 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1327575 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1327576 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1327577 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1327578 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/95604029526376456-127.0.0.1:46690_-n_0000000001
[junit4] 2> 1327578 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/95604029526376452-127.0.0.1:50594_-n_0000000000 to
know if I could be the leader
[junit4] 2> 1327579 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.ZkController Publish node=127.0.0.1:46690_ as
DOWN
[junit4] 2> 1327580 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:46690_"} current state version: 3
[junit4] 2> 1327581 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.NodeMutator DownNode state invoked for node:
127.0.0.1:46690_
[junit4] 2> 1327685 INFO
(zkCallback-1432-thread-1-processing-n:127.0.0.1:46690_) [n:127.0.0.1:46690_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 1327685 INFO (zkCallback-1427-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: [1])
[junit4] 2> 1327685 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 1328581 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46690_
[junit4] 2> 1328581 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:46690_
[junit4] 2> 1328582 INFO (zkCallback-1427-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 1328582 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 1328582 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1328583 INFO (zkCallback-1427-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1328583 INFO
(zkCallback-1432-thread-1-processing-n:127.0.0.1:46690_) [n:127.0.0.1:46690_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 1328585 INFO
(zkCallback-1432-thread-1-processing-n:127.0.0.1:46690_) [n:127.0.0.1:46690_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1328591 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1328591 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1328592 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores
[junit4] 2> 1328593 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=collection1, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1328593 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores/collection1
[junit4] 2> 1328593 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1328611 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1328611 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1328613 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:46690";,
[junit4] 2> "node_name":"127.0.0.1:46690_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 4
[junit4] 2> 1328613 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:46690";,
[junit4] 2> "node_name":"127.0.0.1:46690_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 1328613 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 1328613 INFO
(OverseerStateUpdate-95604029526376452-127.0.0.1:50594_-n_0000000000)
[n:127.0.0.1:50594_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 1328614 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController look
for our core node name
[junit4] 2> 1328627 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
[junit4] 2> 1328627 INFO
(TEST-DistribDocExpirationUpdateProcessorTest.test-seed#[89084DC3E22E3B])
[n:127.0.0.1:46690_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1328715 INFO (zkCallback-1427-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: [2])
[junit4] 2> 1328715 INFO
(zkCallback-1425-thread-1-processing-n:127.0.0.1:50594_) [n:127.0.0.1:50594_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [2])
[junit4] 2> 1328715 INFO
(zkCallback-1432-thread-1-processing-n:127.0.0.1:46690_) [n:127.0.0.1:46690_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [2])
[junit4] 2> 1329614 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController waiting
to find shard id in clusterstate for collection1
[junit4] 2> 1329615 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController Check
for collection zkNode:collection1
[junit4] 2> 1329615 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 1329615 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load
collection config from: [/collections/collection1]
[junit4] 2> 1329615 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader
path=[/collections/collection1] [configName]=[conf1] specified config exists in
ZooKeeper
[junit4] 2> 1329616 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.DistribDocExpirationUpdateProcessorTest_89084DC3E22E3B-001/shard-1-001/cores/collection1'
[junit4] 2> 1329616 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1329616 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1329617 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.Config loaded config
solrconfig.xml with version 0
[junit4] 2> 1329622 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrConfig current
version of requestparams : -1
[junit4] 2> 1329626 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.1.0
[junit4] 2> 1329662 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.c.SolrConfig Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 1329671 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1329799 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.s.IndexSchema default
search field in schema is text
[junit4] 2> 1329800 INFO
(coreLoadExecutor-3391-thread-1-processing-n:127.0.0.1:46690_)
[n:127.0.0.1:46690_ c:collection1 x:collection1] o.a.s.s.IndexSchema unique
key field: id
[junit4] 2
[...truncated too long message...]
g-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.1.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.2.jar
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160324_061951_651.events
@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160324_061951_651.suites
-stdin
[junit4] ERROR: JVM J1 ended with an exception: Quit event not received from
the forked process? This may indicate JVM crash or runner bugs.
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952)
[junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] at java.lang.Thread.run(Thread.java:745)
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
At least one slave process threw an exception, first: Quit event not received
from the forked process? This may indicate JVM crash or runner bugs.
Total time: 231 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
