Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19902/
Java: 32bit/jdk1.8.0_131 -server -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.update.AutoCommitTest.testMaxTime
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([764D767861FACD2E:ECB90B9AFF605112]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890)
at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
... 40 more
FAILED:
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testArraySort
Error Message:
--> http://127.0.0.1:32915/solr/collection1:Invalid stream expression
arraySort(array(11.5,12.3,4,3,1,0)) - function 'arraySort' is unknown (not
mapped to a valid TupleStream)
Stack Trace:
java.io.IOException: --> http://127.0.0.1:32915/solr/collection1:Invalid stream
expression arraySort(array(11.5,12.3,4,3,1,0)) - function 'arraySort' is
unknown (not mapped to a valid TupleStream)
at
__randomizedtesting.SeedInfo.seed([3F36CB7615EBC6D8:9801D5B92323AA1]:0)
at
org.apache.solr.client.solrj.io.stream.SolrStream.read(SolrStream.java:219)
at
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.getTuples(StreamExpressionTest.java:7487)
at
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testArraySort(StreamExpressionTest.java:5840)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12137 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001/init-core-data-001
[junit4] 2> 1210202 WARN
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1210203 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1210203 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1210204 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1210204 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1210224 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1210309 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1210398 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1210445 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1210449 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1210449 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1210451 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1210480 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1210505 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1210643 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1210648 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1210648 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1210648 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1210648 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001/init-core-data-001/]
[junit4] 2> 1210650 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@edb9aa
[junit4] 2> 1210692 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1210692 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1210693 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1210693 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1210694 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=43, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=26.7333984375,
floorSegmentMB=1.5107421875, forceMergeDeletesPctAllowed=4.6868524283757065,
segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1210694 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@56532f[collection1]
main]
[junit4] 2> 1210695 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1210713 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1210790 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1210790 INFO (coreLoadExecutor-5093-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1570582368250494976
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1210791 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1210792 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1210792 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1210793 INFO
(searcherExecutor-5094-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@56532f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1210794 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1210796 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 1210796 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1210796 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@b64a5e[collection1] realtime]
[junit4] 2> 1210797 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1210797 ERROR
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1210797 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1210829 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1210851 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1210950 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1210956 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ ]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 1210980 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry
'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1210980 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001/init-core-data-001/]
[junit4] 2> 1211045 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1211045 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1211047 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@15692b0[collection1] main]
[junit4] 2> 1211048 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1211048 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1211051 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1211051 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1570582368524173312
[junit4] 2> 1211053 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1211054 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1211057 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@15692b0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1211057 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=24, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=93.9619140625,
floorSegmentMB=1.384765625, forceMergeDeletesPctAllowed=17.742522145292707,
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1211058 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1211058 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1806904[collection1] main]
[junit4] 2> 1211058 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@162a830
[junit4] 2> 1211059 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=23242800
[junit4] 2> 1211070 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1806904[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1211071 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1570582368541999104)]} 0 3
[junit4] 2> 1211072 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1
(1570582368545144832)]} 0 4
[junit4] 2> 1211072 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2
(1570582368546193408)]} 0 4
[junit4] 2> 1211072 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1570582368546193409)]} 0 4
[junit4] 2> 1211073 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4
(1570582368547241984)]} 0 4
[junit4] 2> 1211170 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5
(1570582368648953856)]} 0 102
[junit4] 2> 1211170 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1570582368648953857)]} 0 102
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7
(1570582368648953858)]} 0 102
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8
(1570582368650002432)]} 0 102
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1570582368650002433)]} 0 103
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10
(1570582368650002434)]} 0 103
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11
(1570582368650002435)]} 0 103
[junit4] 2> 1211171 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1570582368650002436)]} 0 103
[junit4] 2> 1211172 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13
(1570582368650002437)]} 0 103
[junit4] 2> 1211172 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1211198 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14
(1570582368664682496)]} 0 129
[junit4] 2> 1211206 INFO (commitScheduler-5102-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1211208 INFO (commitScheduler-5102-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@806e62[collection1]
main]
[junit4] 2> 1211211 INFO
(searcherExecutor-5099-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@806e62[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C15)))}
[junit4] 2> 1211211 INFO (commitScheduler-5102-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1211448 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1570582368940457984)]} 0 380
[junit4] 2> 1211449 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 1211450 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1211450 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> 1211452 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 1211452 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1211452 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@11d9b94[collection1] realtime]
[junit4] 2> 1211453 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1211453 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1211453 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1211484 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1211509 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1211601 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1211613 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 1211634 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry
'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1211634 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001/init-core-data-001/]
[junit4] 2> 1211734 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1211734 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1211735 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@12aae18[collection1] main]
[junit4] 2> 1211736 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1211737 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1211739 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1211741 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=62.6650390625,
floorSegmentMB=0.5029296875, forceMergeDeletesPctAllowed=22.66392686229204,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.48071031039456547
[junit4] 2> 1211742 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1211766 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1211766 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1211766 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1211766 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1211766 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1211767 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1211767 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1211767 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1211767 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1211769 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@12aae18[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1211769 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@19cfdf6[collection1] main]
[junit4] 2> 1211770 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@ead6f7
[junit4] 2> 1211770 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=15390455
[junit4] 2> 1211779 INFO
(searcherExecutor-5103-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@19cfdf6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1211785 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1570582369281245184)]} 0 12
[junit4] 2> 1211786 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1211786 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1570582369294876672)]} 0 13
[junit4] 2> 1211787 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1211787 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> 1211787 ERROR
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.SolrTestCaseJ4 REQUEST FAILED:
q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException:
REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
[junit4] 2> at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1211788 INFO
(TEST-AutoCommitTest.testMaxTime-seed#[764D767861FACD2E]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxTime -Dtests.seed=764D767861FACD2E -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=en-CA -Dtests.timezone=Indian/Mauritius
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.34s J2 | AutoCommitTest.testMaxTime <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([764D767861FACD2E:ECB90B9AFF605112]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890)
[junit4] > at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request
was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:883)
[junit4] > ... 40 more
[junit4] 2> 1211803 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 1211803 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL
DOCUMENTS FROM INDEX
[junit4] 2> 1211803 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@d90bad[collection1]
realtime]
[junit4] 2> 1211804 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1211804 ERROR
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/core.properties
[junit4] 2> 1211804 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1211854 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1211904 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1212096 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1212102 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 1212141 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fd00f5
[junit4] 2> 1212144 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001/init-core-data-001/]
[junit4] 2> 1212223 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1212223 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1212224 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@768285[collection1]
main]
[junit4] 2> 1212226 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1212226 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1212229 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1212231 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1212231 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1212232 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1212235 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@768285[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1212235 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=48, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=84.4462890625,
floorSegmentMB=1.1533203125, forceMergeDeletesPctAllowed=20.23822413671707,
segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.3743177879333207
[junit4] 2> 1212236 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1212236 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@11e5e9b[collection1]
main]
[junit4] 2> 1212236 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@d68703
[junit4] 2> 1212239 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@11e5e9b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1212239 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=14059267
[junit4] 2> 1212248 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529
(1570582369778270208)]} 0 1
[junit4] 2> 1212248 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1216248 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1216252 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3c1563[collection1]
main]
[junit4] 2> 1216252 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1216253 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3c1563[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C1)))}
[junit4] 2> 1216282 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530
(1570582373996691456)]} 0 4034
[junit4] 2> 1216282 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1216283 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529
(-1570582374009274368)]} 0 4035
[junit4] 2> 1216283 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 1218283 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1218285 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c5c198[collection1]
main]
[junit4] 2> 1218286 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1218287 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1c5c198[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C1)))}
[junit4] 2> 1218288 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1218288 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 1218289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376112717824)]} 0 6041
[junit4] 2> 1218289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376113766400)]} 0 6042
[junit4] 2> 1218289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376113766401)]} 0 6042
[junit4] 2> 1218289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376113766402)]} 0 6042
[junit4] 2> 1218289 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376113766403)]} 0 6042
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376114814976)]} 0 6042
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376114814977)]} 0 6042
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376114814978)]} 0 6042
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376114814979)]} 0 6042
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1570582376114814980)]} 0 6043
[junit4] 2> 1218290 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863552)]} 0 6043
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863553)]} 0 6043
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863554)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863555)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863556)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863557)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863558)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863559)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863560)]} 0 6044
[junit4] 2> 1218291 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530
(-1570582376115863561)]} 0 6044
[junit4] 2> 1218292 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 1219291 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1219293 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d01b4c[collection1]
main]
[junit4] 2> 1219293 INFO (commitScheduler-5110-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1219295 INFO
(searcherExecutor-5107-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1d01b4c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C10/9:delGen=1)))}
[junit4] 2> 1219298 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0
QTime=0
[junit4] 2> 1219298 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0
QTime=0
[junit4] 2> 1219298 INFO
(TEST-AutoCommitTest.testCommitWithin-seed#[764D767861FACD2E]) [
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> 1219299 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1219299 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=27545566
[junit4] 2> 1219299 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1219300 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1219301 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1219301 INFO
(SUITE-AutoCommitTest-seed#[764D767861FACD2E]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1219302 INFO
(coreCloseExecutor-5111-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@368123
[junit4] 2> 1219302 INFO
(coreCloseExecutor-5111-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 1219302 INFO
(coreCloseExecutor-5111-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1dd92e3 commitCommandVersion:0
[junit4] 2> 1219314 INFO
(coreCloseExecutor-5111-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=3572003
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_764D767861FACD2E-001
[junit4] 2> Jun 18, 2017 10:14:34 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{field_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
multiDefault=PostingsFormat(name=Memory), subject=PostingsFormat(name=Memory),
id_i1=PostingsFormat(name=Memory), id=PostingsFormat(name=Asserting),
text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Asserting),
intDefault=DocValuesFormat(name=Asserting),
range_facet_i_dv=DocValuesFormat(name=Asserting),
intDvoDefault=DocValuesFormat(name=Lucene70),
range_facet_l=DocValuesFormat(name=Asserting),
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=754,
maxMBSortInHeap=7.09866577257769, sim=RandomSimilarity(queryNorm=true): {},
locale=en-CA, timezone=Indian/Mauritius
[junit4] 2> NOTE: Linux 4.10.0-21-generic i386/Oracle Corporation
1.8.0_131 (32-bit)/cpus=8,threads=1,free=191038904,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[OutOfBoxZkACLAndCredentialsProvidersTest, CollectionsAPISolrJTest,
TestConfigSetsAPIExclusivity, TestGraphTermsQParserPlugin,
SaslZkACLProviderTest, TestLRUStatsCache, TestMaxTokenLenTokenizer,
TestCorePropertiesReload, VersionInfoTest, HdfsNNFailoverTest, TestNRTOpen,
TestPayloadCheckQParserPlugin, SimpleFacetsTest, OverseerModifyCollectionTest,
RemoteQueryErrorTest, BlockJoinFacetSimpleTest, HdfsLockFactoryTest,
FieldMutatingUpdateProcessorTest, TestClassicSimilarityFactory,
TestXmlQParserPlugin, SolrGraphiteReporterTest, TestDistributedMissingSort,
CachingDirectoryFactoryTest, RestartWhileUpdatingTest, TestSolrCoreParser,
SharedFSAutoReplicaFailoverUtilsTest, TestPhraseSuggestions,
TestExpandComponent, TestPolicyCloud, MetricsConfigTest,
TestMiniSolrCloudClusterSSL, ForceLeaderTest, BlockDirectoryTest,
SolrCloudExampleTest, TestIBSimilarityFactory, SuggesterTest,
TermVectorComponentDistributedTest, TestSolrDeletionPolicy1,
TestManagedSchemaAPI, SolrPluginUtilsTest, OverseerTest,
TestSolrCloudWithKerberosAlt, TestShortCircuitedRequests,
DistribCursorPagingTest, RankQueryTest, SolrMetricReporterTest, TestWriterPerf,
TestTolerantUpdateProcessorCloud, UpdateParamsTest, ShowFileRequestHandlerTest,
TestBinaryResponseWriter, TestInPlaceUpdatesDistrib,
TestPerFieldSimilarityWithDefaultOverride, DocValuesMissingTest, TestConfig,
HLLSerializationTest, AtomicUpdatesTest, TestMultiValuedNumericRangeQuery,
TestComponentsName, TestManagedResourceStorage, TestSolrCLIRunExample,
ChaosMonkeyNothingIsSafeTest, UnloadDistributedZkTest, TestCloudDeleteByQuery,
TestConfigSetImmutable, TestZkChroot, TestRandomCollapseQParserPlugin,
TestFieldCacheVsDocValues, TestReload, V2StandaloneTest,
TestImplicitCoreProperties, TestRecovery, TestManagedSynonymFilterFactory,
DirectoryFactoryTest, TestJettySolrRunner, TestIndexingPerformance,
TestSolrQueryParser, TestBlobHandler, TestSimpleTextCodec, ResponseHeaderTest,
TestNumericTokenStream, HdfsChaosMonkeyNothingIsSafeTest,
TestMergePolicyConfig, TestSimpleQParserPlugin, ReplicaListTransformerTest,
TestUseDocValuesAsStored2, TestSort, TestNestedDocsSort, TestConfigsApi,
RecoveryZkTest, TestLegacyFieldReuse, SuggesterTSTTest, SolrCloudReportersTest,
RequestHandlersTest, TestLMDirichletSimilarityFactory, TestLuceneMatchVersion,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestNumericTerms32,
BitVectorTest, OverseerTaskQueueTest, TestPullReplicaErrorHandling,
CircularListTest, NoCacheHeaderTest, TestSubQueryTransformerCrossCore,
TestCloudManagedSchema, BooleanFieldTest, MBeansHandlerTest,
TestCollapseQParserPlugin, DistributedExpandComponentTest,
OpenExchangeRatesOrgProviderTest, TestImpersonationWithHadoopAuth,
WrapperMergePolicyFactoryTest, DistributedFacetPivotLongTailTest,
TestLegacyNumericRangeQueryBuilder, TestExclusionRuleCollectionAccess,
DirectUpdateHandlerTest, BasicDistributedZkTest, BasicDistributedZk2Test,
SyncSliceTest, OpenCloseCoreStressTest, ShardRoutingTest, BasicZkTest,
FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest,
ZkSolrClientTest, AutoCommitTest]
[junit4] Completed [377/725 (1!)] on J2 in 9.38s, 3 tests, 1 error <<<
FAILURES!
[...truncated 1754 lines...]
[junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/init-core-data-001
[junit4] 2> 28519 WARN
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=35 numCloses=35
[junit4] 2> 28520 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 28521 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 28522 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/tempDir-001
[junit4] 2> 28522 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 28522 INFO (Thread-61) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 28522 INFO (Thread-61) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 28562 ERROR (Thread-61) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 28622 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:39971
[junit4] 2> 28647 INFO (jetty-launcher-149-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 28662 INFO (jetty-launcher-149-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 28665 INFO (jetty-launcher-149-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 28678 INFO (jetty-launcher-149-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 28694 INFO (jetty-launcher-149-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@16ae733{/solr,null,AVAILABLE}
[junit4] 2> 28700 INFO (jetty-launcher-149-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@146827{HTTP/1.1,[http/1.1]}{127.0.0.1:41815}
[junit4] 2> 28700 INFO (jetty-launcher-149-thread-1) [ ]
o.e.j.s.Server Started @30907ms
[junit4] 2> 28700 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41815}
[junit4] 2> 28701 ERROR (jetty-launcher-149-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 28701 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 28701 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 28701 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 28701 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-18T22:26:05.564Z
[junit4] 2> 28722 INFO (jetty-launcher-149-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@12cfaba{/solr,null,AVAILABLE}
[junit4] 2> 28722 INFO (jetty-launcher-149-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@170739a{HTTP/1.1,[http/1.1]}{127.0.0.1:32915}
[junit4] 2> 28722 INFO (jetty-launcher-149-thread-3) [ ]
o.e.j.s.Server Started @30929ms
[junit4] 2> 28722 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=32915}
[junit4] 2> 28722 ERROR (jetty-launcher-149-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 28723 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 28723 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 28723 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 28723 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-18T22:26:05.586Z
[junit4] 2> 28768 INFO (jetty-launcher-149-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e42bee{/solr,null,AVAILABLE}
[junit4] 2> 28769 INFO (jetty-launcher-149-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1d97148{HTTP/1.1,[http/1.1]}{127.0.0.1:36243}
[junit4] 2> 28769 INFO (jetty-launcher-149-thread-2) [ ]
o.e.j.s.Server Started @30976ms
[junit4] 2> 28769 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36243}
[junit4] 2> 28772 ERROR (jetty-launcher-149-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 28772 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 28772 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 28772 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 28772 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-18T22:26:05.635Z
[junit4] 2> 28803 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 28820 INFO (jetty-launcher-149-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1d88774{/solr,null,AVAILABLE}
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@103928{HTTP/1.1,[http/1.1]}{127.0.0.1:35697}
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.e.j.s.Server Started @31028ms
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35697}
[junit4] 2> 28821 ERROR (jetty-launcher-149-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 28821 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-06-18T22:26:05.684Z
[junit4] 2> 28878 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 28901 INFO (jetty-launcher-149-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 28902 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 28902 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 28946 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15cbd5025e50005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 28951 INFO (jetty-launcher-149-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 28952 INFO (jetty-launcher-149-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 29009 INFO (jetty-launcher-149-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 29094 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 29102 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:32915_solr
[junit4] 2> 29103 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.c.Overseer Overseer
(id=98161443826106374-127.0.0.1:32915_solr-n_0000000000) starting
[junit4] 2> 29117 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 29118 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36243_solr
[junit4] 2> 29163 INFO
(OverseerStateUpdate-98161443826106374-127.0.0.1:32915_solr-n_0000000000)
[n:127.0.0.1:32915_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 29165 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:32915_solr
[junit4] 2> 29166 INFO
(zkCallback-170-thread-1-processing-n:127.0.0.1:36243_solr)
[n:127.0.0.1:36243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 29168 INFO
(zkCallback-170-thread-1-processing-n:127.0.0.1:36243_solr)
[n:127.0.0.1:36243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 29169 INFO
(zkCallback-162-thread-1-processing-n:127.0.0.1:32915_solr)
[n:127.0.0.1:32915_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 29181 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 29183 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 29184 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 29185 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 29186 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35697_solr
[junit4] 2> 29188 INFO
(zkCallback-170-thread-1-processing-n:127.0.0.1:36243_solr)
[n:127.0.0.1:36243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 29189 INFO
(zkCallback-162-thread-1-processing-n:127.0.0.1:32915_solr)
[n:127.0.0.1:32915_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 29190 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41815_solr
[junit4] 2> 29197 INFO
(zkCallback-170-thread-1-processing-n:127.0.0.1:36243_solr)
[n:127.0.0.1:36243_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 29208 INFO
(zkCallback-162-thread-1-processing-n:127.0.0.1:32915_solr)
[n:127.0.0.1:32915_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 29215 INFO
(zkCallback-171-thread-1-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 29217 INFO
(zkCallback-171-thread-2-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 29222 INFO
(zkCallback-169-thread-1-processing-n:127.0.0.1:35697_solr)
[n:127.0.0.1:35697_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (4)
[junit4] 2> 29392 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32915.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29396 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32915.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29396 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32915.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29397 INFO (jetty-launcher-149-thread-3)
[n:127.0.0.1:32915_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/tempDir-001/node3/.
[junit4] 2> 29432 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36243.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29435 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36243.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29436 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36243.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29437 INFO (jetty-launcher-149-thread-2)
[n:127.0.0.1:36243_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/tempDir-001/node2/.
[junit4] 2> 29444 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35697.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29446 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35697.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29446 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35697.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29447 INFO (jetty-launcher-149-thread-4)
[n:127.0.0.1:35697_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/tempDir-001/node4/.
[junit4] 2> 29529 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41815.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29537 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41815.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29537 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_41815.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1d7716d
[junit4] 2> 29538 INFO (jetty-launcher-149-thread-1)
[n:127.0.0.1:41815_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001/tempDir-001/node1/.
[junit4] 2> 29574 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 29575 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39971/solr ready
[junit4] 2> 29643 INFO (qtp23420744-480) [n:127.0.0.1:32915_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=collection1_collection&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 29649 INFO
(OverseerThreadFactory-116-thread-1-processing-n:127.0.0.1:32915_solr)
[n:127.0.0.1:32915_solr ] o.a.s.c.CreateCollectionCmd Create collection
collection1_collection
[junit4] 2> 29762 INFO (qtp791601-503) [n:127.0.0.1:35697_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_collection_shard2_replica_n1&action=CREATE&numShards=2&collection=collection1_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 29762 INFO (qtp791601-503) [n:127.0.0.1:35697_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 29763 INFO (qtp22382370-472) [n:127.0.0.1:41815_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_collection_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 29763 INFO (qtp22382370-472) [n:127.0.0.1:41815_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 29867 INFO
(zkCallback-169-thread-1-processing-n:127.0.0.1:35697_solr)
[n:127.0.0.1:35697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_collection/state.json] for collection
[collection1_collection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 29867 INFO
(zkCallback-171-thread-2-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1_collection/state.json] for collection
[collection1_collection] has occurred - updating..
[...truncated too long message...]
] 2> 107656 INFO (coreCloseExecutor-256-thread-1) [n:127.0.0.1:35697_solr
c:collection1_collection s:shard2 r:core_node1
x:collection1_collection_shard2_replica_n1] o.a.s.c.SolrCore
[collection1_collection_shard2_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@10770bd
[junit4] 2> 107656 INFO (coreCloseExecutor-257-thread-1)
[n:127.0.0.1:41815_solr c:collection1_collection s:shard1 r:core_node2
x:collection1_collection_shard1_replica_n1] o.a.s.c.SolrCore
[collection1_collection_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@ba6b09
[junit4] 2> 107657 INFO (coreCloseExecutor-256-thread-1)
[n:127.0.0.1:35697_solr c:collection1_collection s:shard2 r:core_node1
x:collection1_collection_shard2_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.core.collection1_collection.shard2.replica_n1, tag=17264829
[junit4] 2> 107659 INFO (coreCloseExecutor-256-thread-1)
[n:127.0.0.1:35697_solr c:collection1_collection s:shard2 r:core_node1
x:collection1_collection_shard2_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.collection1_collection.shard2.leader, tag=17264829
[junit4] 2> 107660 INFO (coreCloseExecutor-257-thread-1)
[n:127.0.0.1:41815_solr c:collection1_collection s:shard1 r:core_node2
x:collection1_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.core.collection1_collection.shard1.replica_n1, tag=12217097
[junit4] 2> 107661 WARN
(zkCallback-169-thread-1-processing-n:127.0.0.1:35697_solr)
[n:127.0.0.1:35697_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 107661 INFO (jetty-closer-150-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=98161443826106374-127.0.0.1:32915_solr-n_0000000000) closing
[junit4] 2> 107661 INFO
(zkCallback-171-thread-2-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (2)
[junit4] 2> 107661 INFO
(OverseerStateUpdate-98161443826106374-127.0.0.1:32915_solr-n_0000000000)
[n:127.0.0.1:32915_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:32915_solr
[junit4] 2> 107661 INFO (jetty-closer-150-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1d88774{/solr,null,UNAVAILABLE}
[junit4] 2> 107661 INFO
(zkCallback-162-thread-2-processing-n:127.0.0.1:32915_solr)
[n:127.0.0.1:32915_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (2)
[junit4] 2> 107661 INFO
(zkCallback-171-thread-3-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41815_solr
[junit4] 2> 107662 INFO
(zkCallback-171-thread-2-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 107662 INFO (jetty-closer-150-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@12cfaba{/solr,null,UNAVAILABLE}
[junit4] 2> 107663 INFO (coreCloseExecutor-257-thread-1)
[n:127.0.0.1:41815_solr c:collection1_collection s:shard1 r:core_node2
x:collection1_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.collection1_collection.shard1.leader, tag=12217097
[junit4] 2> 107663 WARN
(zkCallback-171-thread-3-processing-n:127.0.0.1:41815_solr)
[n:127.0.0.1:41815_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 107663 INFO (jetty-closer-150-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@16ae733{/solr,null,UNAVAILABLE}
[junit4] 2> 109161 WARN
(zkCallback-170-thread-2-processing-n:127.0.0.1:36243_solr)
[n:127.0.0.1:36243_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 109161 INFO (jetty-closer-150-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1e42bee{/solr,null,UNAVAILABLE}
[junit4] 2> 109161 ERROR
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 109162 INFO
(SUITE-StreamExpressionTest-seed#[3F36CB7615EBC6D8]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39971 39971
[junit4] 2> 109175 INFO (Thread-61) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:39971 39971
[junit4] 2> 109175 WARN (Thread-61) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 70 /solr/aliases.json
[junit4] 2> 70 /solr/clusterprops.json
[junit4] 2> 8 /solr/configs/conf
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 70 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/destination/state.json
[junit4] 2> 4
/solr/collections/parallelDestinationCollection/state.json
[junit4] 2> 4
/solr/collections/destinationCollection/state.json
[junit4] 2> 4 /solr/collections/mainCorpus/state.json
[junit4] 2> 2
/solr/collections/collection1_collection/state.json
[junit4] 2> 2 /solr/collections/workQueue/state.json
[junit4] 2> 2
/solr/collections/parallelDestinationCollection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 70 /solr/live_nodes
[junit4] 2> 70 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_3F36CB7615EBC6D8-001
[junit4] 2> Jun 18, 2017 10:27:26 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{expr_s=Lucene50(blocksize=128),
join2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
subject=PostingsFormat(name=LuceneVarGapDocFreqInterval),
price_f=PostingsFormat(name=LuceneVarGapDocFreqInterval),
a1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
a_f=PostingsFormat(name=LuceneVarGapDocFreqInterval),
join1_i=Lucene50(blocksize=128), a2_s=PostingsFormat(name=Direct),
a_i=Lucene50(blocksize=128), join3_i=PostingsFormat(name=Direct),
test_i=PostingsFormat(name=LuceneVarGapDocFreqInterval),
field_i=PostingsFormat(name=LuceneVarGapDocFreqInterval),
level1_s=Lucene50(blocksize=128), body_t=PostingsFormat(name=Direct),
s_multi=PostingsFormat(name=Direct),
col_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
level2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
a_ss=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
a_s=PostingsFormat(name=Direct),
a_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
id=Lucene50(blocksize=128), text=PostingsFormat(name=Direct),
timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
i_multi=Lucene50(blocksize=128),
b_ls=PostingsFormat(name=LuceneVarGapDocFreqInterval),
test_dt=Lucene50(blocksize=128), test_t=PostingsFormat(name=Direct),
ident_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
order_i=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
side_s=PostingsFormat(name=Direct),
miles_i=PostingsFormat(name=LuceneVarGapDocFreqInterval)},
docValues:{expr_s=DocValuesFormat(name=Asserting),
join2_s=DocValuesFormat(name=Memory),
multiDefault=DocValuesFormat(name=Memory),
price_f=DocValuesFormat(name=Memory), a1_s=DocValuesFormat(name=Memory),
intDefault=DocValuesFormat(name=Lucene70), a_f=DocValuesFormat(name=Memory),
join1_i=DocValuesFormat(name=Asserting), a2_s=DocValuesFormat(name=Direct),
a_i=DocValuesFormat(name=Asserting), join3_i=DocValuesFormat(name=Direct),
test_i=DocValuesFormat(name=Memory), field_i=DocValuesFormat(name=Memory),
level1_s=DocValuesFormat(name=Asserting), s_multi=DocValuesFormat(name=Direct),
col_s=DocValuesFormat(name=Memory), level2_s=DocValuesFormat(name=Lucene70),
a_ss=DocValuesFormat(name=Lucene70), a_s=DocValuesFormat(name=Direct),
id=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Lucene70),
i_multi=DocValuesFormat(name=Asserting), b_ls=DocValuesFormat(name=Memory),
test_dt=DocValuesFormat(name=Asserting), ident_s=DocValuesFormat(name=Memory),
order_i=DocValuesFormat(name=Memory), _version_=DocValuesFormat(name=Lucene70),
side_s=DocValuesFormat(name=Direct), miles_i=DocValuesFormat(name=Memory)},
maxPointsInLeafNode=250, maxMBSortInHeap=6.923249491250587,
sim=RandomSimilarity(queryNorm=false): {}, locale=ru, timezone=Kwajalein
[junit4] 2> NOTE: Linux 4.10.0-21-generic i386/Oracle Corporation
1.8.0_131 (32-bit)/cpus=8,threads=1,free=82131736,total=184549376
[junit4] 2> NOTE: All tests run in this JVM: [TestV2Request,
AndEvaluatorTest, TestUpdateRequestCodec, GraphExpressionTest,
TestDelegationTokenResponse, StreamExpressionTest]
[junit4] Completed [68/135 (1!)] on J1 in 81.77s, 89 tests, 1 error, 9
skipped <<< FAILURES!
[...truncated 38826 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
