You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/07/29 09:53:53 UTC
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk1.8.0_141) - Build # 163
- Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/163/
Java: 64bit/jdk1.8.0_141 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([39B1A0EF0EB982F6:C16F350776D553A5]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion(SegmentsInfoRequestHandlerTest.java:68)
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=2=count(//lst[@name='segments']/lst/str[@name='version'][.='7.1.0'])
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><lst name="segments"><lst name="_0"><str name="name">_0</str><int name="delCount">1</int><long name="sizeInBytes">1558</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.130Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_1"><str name="name">_1</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.133Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_2"><str name="name">_2</str><int name="delCount">0</int><long name="sizeInBytes">1491</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.182Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_3"><str name="name">_3</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.184Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst></lst>
</response>
request was:qt=/admin/segments&wt=xml
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
... 40 more
FAILED: org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([39B1A0EF0EB982F6:1583D762827DF472]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264)
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=int_i:14&wt=xml
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
... 40 more
Build Log:
[...truncated 11031 lines...]
[junit4] Suite: org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_39B1A0EF0EB982F6-001/init-core-data-001
[junit4] 2> 210400 WARN (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 210400 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 210401 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 210402 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 210402 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 210402 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 210416 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 210427 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 210466 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 210495 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53175015
[junit4] 2> 210497 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53175015
[junit4] 2> 210497 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53175015
[junit4] 2> 210498 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 210515 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 210526 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 210567 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 210572 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 210572 INFO (coreLoadExecutor-1336-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@53175015
[junit4] 2> 210572 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 210572 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_39B1A0EF0EB982F6-001/init-core-data-001/]
[junit4] 2> 210573 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7400869800971004]
[junit4] 2> 210598 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 210598 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 210599 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 210599 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 210599 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 210600 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e0e9559[collection1] main]
[junit4] 2> 210600 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 210844 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 211438 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 211438 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 211438 INFO (coreLoadExecutor-1336-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574247664540712960
[junit4] 2> 211439 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 211439 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 211439 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 211439 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 211439 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 211440 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 211440 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 211440 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 211442 INFO (searcherExecutor-1337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3e0e9559[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 211443 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 211446 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBasics
[junit4] 2> 211451 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574247664554344448,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 211451 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1f9d4ba6 commitCommandVersion:1574247664554344448
[junit4] 2> 211459 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4b4297b5[collection1] main]
[junit4] 2> 211459 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 211461 INFO (searcherExecutor-1337-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b4297b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):c1)))}
[junit4] 2> 211461 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 10
[junit4] 2> 211464 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211466 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:human&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211466 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Mr&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211467 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:20&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211467 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name_s:Virat&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211468 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=multiDefault:Delhi&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211470 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574247664574267392,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 211471 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1f9d4ba6 commitCommandVersion:1574247664574267392
[junit4] 2> 211476 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@188975e9[collection1] main]
[junit4] 2> 211476 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 211479 INFO (searcherExecutor-1337-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@188975e9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):c1)))}
[junit4] 2> 211479 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 8
[junit4] 2> 211480 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211480 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:human&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211481 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:animal&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211481 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Mr&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 211482 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=title:Dr&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211482 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:20&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 211482 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=count_i:40&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211483 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=name_s:Virat&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 211483 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=multiDefault:Delhi&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 211483 INFO (TEST-AtomicUpdateProcessorFactoryTest.testBasics-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBasics
[junit4] 2> 211485 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleThreads
[junit4] 2> 211485 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 211486 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a526550[collection1] realtime]
[junit4] 2> 211486 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] 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> 211491 WARN (Thread-789) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664595238912 actual=1574247664596287488Retrying with new version .... (1)
[junit4] 2> 211491 WARN (Thread-787) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664595238912 actual=1574247664596287488Retrying with new version .... (1)
[junit4] 2> 211492 WARN (Thread-788) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664595238912 actual=1574247664596287488Retrying with new version .... (1)
[junit4] 2> 211492 WARN (Thread-786) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664595238912 actual=1574247664597336064Retrying with new version .... (1)
[junit4] 2> 211492 WARN (Thread-783) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664595238912 actual=1574247664597336064Retrying with new version .... (1)
[junit4] 2> 211492 WARN (Thread-785) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664592093184 actual=1574247664597336065Retrying with new version .... (1)
[junit4] 2> 211492 WARN (Thread-784) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664592093184 actual=1574247664597336065Retrying with new version .... (1)
[junit4] 2> 211493 WARN (Thread-784) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664597336065 actual=1574247664597336066Retrying with new version .... (2)
[junit4] 2> 211493 WARN (Thread-783) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664597336064 actual=1574247664597336066Retrying with new version .... (2)
[junit4] 2> 211493 WARN (Thread-788) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664596287488 actual=1574247664597336066Retrying with new version .... (2)
[junit4] 2> 211493 WARN (Thread-787) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664596287488 actual=1574247664598384640Retrying with new version .... (2)
[junit4] 2> 211493 WARN (Thread-783) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664597336066 actual=1574247664598384640Retrying with new version .... (3)
[junit4] 2> 211493 WARN (Thread-788) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664597336066 actual=1574247664598384640Retrying with new version .... (3)
[junit4] 2> 211493 WARN (Thread-783) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664598384640 actual=1574247664598384641Retrying with new version .... (4)
[junit4] 2> 211493 WARN (Thread-788) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664598384640 actual=1574247664598384641Retrying with new version .... (4)
[junit4] 2> 211493 WARN (Thread-788) [ ] o.a.s.u.p.AtomicUpdateProcessorFactory Atomic update failed due to version conflict for 10 expected=1574247664598384641 actual=1574247664598384642Retrying with new version .... (5)
[junit4] 2> 211494 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1574247664599433216,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 211494 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1f9d4ba6 commitCommandVersion:1574247664599433216
[junit4] 2> 211498 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@31cc0648[collection1] main]
[junit4] 2> 211498 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 211500 INFO (searcherExecutor-1337-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@31cc0648[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.1.0):c10/9:delGen=1)))}
[junit4] 2> 211500 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6
[junit4] 2> 211501 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211502 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=cat:bebyg9dhqwxldut1pz4m+dh0xl3i9wojiaprige0t+9ovr62xej3v76t6qklar+w6n10rdooy68k9lwer0j+su4vl7hwtj79mtrivy5n&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 211503 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=int_i:14&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 211503 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] 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=int_i:14&wt=xml
[junit4] 2> 211504 ERROR (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=int_i:14&wt=xml: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=int_i:14&wt=xml
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] 2> at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264)
[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> 211504 INFO (TEST-AtomicUpdateProcessorFactoryTest.testMultipleThreads-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleThreads
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AtomicUpdateProcessorFactoryTest -Dtests.method=testMultipleThreads -Dtests.seed=39B1A0EF0EB982F6 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=CET -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.02s J0 | AtomicUpdateProcessorFactoryTest.testMultipleThreads <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([39B1A0EF0EB982F6:1583D762827DF472]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
[junit4] > at org.apache.solr.update.processor.AtomicUpdateProcessorFactoryTest.testMultipleThreads(AtomicUpdateProcessorFactoryTest.java:264)
[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=int_i:14&wt=xml
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] > ... 40 more
[junit4] 2> 211507 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWrongAtomicOpPassed
[junit4] 2> 211507 INFO (TEST-AtomicUpdateProcessorFactoryTest.testWrongAtomicOpPassed-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWrongAtomicOpPassed
[junit4] 2> 211508 INFO (TEST-AtomicUpdateProcessorFactoryTest.testNoUniqueIdPassed-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNoUniqueIdPassed
[junit4] 2> 211508 INFO (TEST-AtomicUpdateProcessorFactoryTest.testNoUniqueIdPassed-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNoUniqueIdPassed
[junit4] 2> 211508 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 211508 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1661626991
[junit4] 2> 211508 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 211509 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 211515 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 211515 INFO (SUITE-AtomicUpdateProcessorFactoryTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 211516 INFO (coreCloseExecutor-1342-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@74a91a38
[junit4] 2> 211516 INFO (coreCloseExecutor-1342-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1957239352
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.processor.AtomicUpdateProcessorFactoryTest_39B1A0EF0EB982F6-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name_s=Lucene50(blocksize=128), title_stringNoNorms=Lucene50(blocksize=128), title_stemmed=PostingsFormat(name=LuceneFixedGap), multiDefault=PostingsFormat(name=LuceneFixedGap), cat=Lucene50(blocksize=128), id=FST50, text=Lucene50(blocksize=128), title=PostingsFormat(name=LuceneFixedGap), title_lettertok=FST50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), _version_=DocValuesFormat(name=Memory), range_facet_i_dv=DocValuesFormat(name=Memory), intDvoDefault=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=832, maxMBSortInHeap=6.307601319033203, sim=RandomSimilarity(queryNorm=false): {}, locale=en-US, timezone=CET
[junit4] 2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 1.8.0_141 (64-bit)/cpus=8,threads=1,free=289775776,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestReplicationHandler, TestConfigSetsAPIExclusivity, TestSortByMinMaxFunction, SolrCoreTest, DistributedFacetPivotWhiteBoxTest, DistribCursorPagingTest, TestReplicaProperties, ZkNodePropsTest, MergeStrategyTest, SolrIndexConfigTest, OutputWriterTest, LeaderInitiatedRecoveryOnShardRestartTest, TestStressLucene, TestMissingGroups, ImplicitSnitchTest, TestFunctionQuery, PreAnalyzedUpdateProcessorTest, MBeansHandlerTest, TestPKIAuthenticationPlugin, TestRangeQuery, StatsReloadRaceTest, TestDynamicFieldResource, AtomicUpdateProcessorFactoryTest]
[junit4] Completed [67/726 (1!)] on J0 in 1.14s, 4 tests, 1 error <<< FAILURES!
[...truncated 1743 lines...]
[junit4] Suite: org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.SegmentsInfoRequestHandlerTest_39B1A0EF0EB982F6-001/init-core-data-001
[junit4] 2> 1864024 WARN (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1864024 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1864026 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1864026 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1864026 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1864026 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1864047 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 1864062 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1864103 WARN (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 1864103 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
[junit4] 2> 1864149 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d1d1a07
[junit4] 2> 1864152 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d1d1a07
[junit4] 2> 1864152 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@d1d1a07
[junit4] 2> 1864153 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1864175 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
[junit4] 2> 1864194 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1864237 WARN (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 1864237 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.4 with uniqueid field id
[junit4] 2> 1864240 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1864240 INFO (coreLoadExecutor-7870-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@d1d1a07
[junit4] 2> 1864240 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1864241 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.SegmentsInfoRequestHandlerTest_39B1A0EF0EB982F6-001/init-core-data-001/]
[junit4] 2> 1864264 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1864265 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1864265 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2e9495ae[collection1] main]
[junit4] 2> 1864265 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1864281 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1864333 INFO (coreLoadExecutor-7870-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1864333 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1864334 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1864334 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1864334 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1864334 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1864335 INFO (searcherExecutor-7871-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2e9495ae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1864335 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR1000]} 0 0
[junit4] 2> 1864337 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR1001]} 0 0
[junit4] 2> 1864337 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR1002]} 0 0
[junit4] 2> 1864340 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR1003]} 0 2
[junit4] 2> 1864340 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR1004]} 0 0
[junit4] 2> 1864340 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[SOLR1000]} 0 0
[junit4] 2> 1864341 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1864341 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@e9be501 commitCommandVersion:0
[junit4] 2> 1864365 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@452d3ce7[collection1] main]
[junit4] 2> 1864365 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1864367 INFO (searcherExecutor-7871-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@452d3ce7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):c4/1:delGen=1) Uninverting(_1(7.1.0):c1)))}
[junit4] 2> 1864384 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 43
[junit4] 2> 1864386 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR2000]} 0 0
[junit4] 2> 1864387 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR2001]} 0 0
[junit4] 2> 1864387 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR2002]} 0 0
[junit4] 2> 1864391 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR2003]} 0 3
[junit4] 2> 1864391 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[SOLR2004]} 0 0
[junit4] 2> 1864391 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1864391 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@e9be501 commitCommandVersion:0
[junit4] 2> 1864393 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@72597c8b[collection1] main]
[junit4] 2> 1864393 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1864394 INFO (searcherExecutor-7871-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@72597c8b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):c4/1:delGen=1) Uninverting(_1(7.1.0):c1) Uninverting(_2(7.1.0):c4) Uninverting(_3(7.1.0):c1)))}
[junit4] 2> 1864394 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 1864397 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosData-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSegmentInfosData
[junit4] 2> 1864398 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosData-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/admin/segments&wt=xml} status=0 QTime=0
[junit4] 2> 1864398 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosData-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSegmentInfosData
[junit4] 2> 1864402 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfos-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSegmentInfos
[junit4] 2> 1864402 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfos-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/admin/segments&wt=xml} status=0 QTime=0
[junit4] 2> 1864402 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfos-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSegmentInfos
[junit4] 2> 1864405 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosVersion-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSegmentInfosVersion
[junit4] 2> 1864406 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosVersion-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/admin/segments&wt=xml} status=0 QTime=0
[junit4] 2> 1864406 ERROR (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosVersion-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=2=count(//lst[@name='segments']/lst/str[@name='version'][.='7.1.0'])
[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><lst name="segments"><lst name="_0"><str name="name">_0</str><int name="delCount">1</int><long name="sizeInBytes">1558</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.130Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_1"><str name="name">_1</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.133Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_2"><str name="name">_2</str><int name="delCount">0</int><long name="sizeInBytes">1491</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.182Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_3"><str name="name">_3</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.184Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst></lst>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:qt=/admin/segments&wt=xml
[junit4] 2> 1864406 ERROR (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosVersion-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 REQUEST FAILED: qt=/admin/segments&wt=xml:java.lang.RuntimeException: REQUEST FAILED: xpath=2=count(//lst[@name='segments']/lst/str[@name='version'][.='7.1.0'])
[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><lst name="segments"><lst name="_0"><str name="name">_0</str><int name="delCount">1</int><long name="sizeInBytes">1558</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.130Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_1"><str name="name">_1</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.133Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_2"><str name="name">_2</str><int name="delCount">0</int><long name="sizeInBytes">1491</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.182Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_3"><str name="name">_3</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.184Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst></lst>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:qt=/admin/segments&wt=xml
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] 2> at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion(SegmentsInfoRequestHandlerTest.java:68)
[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> 1864406 INFO (TEST-SegmentsInfoRequestHandlerTest.testSegmentInfosVersion-seed#[39B1A0EF0EB982F6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSegmentInfosVersion
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SegmentsInfoRequestHandlerTest -Dtests.method=testSegmentInfosVersion -Dtests.seed=39B1A0EF0EB982F6 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lv -Dtests.timezone=Canada/Eastern -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.01s J1 | SegmentsInfoRequestHandlerTest.testSegmentInfosVersion <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([39B1A0EF0EB982F6:C16F350776D553A5]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886)
[junit4] > at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion(SegmentsInfoRequestHandlerTest.java:68)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=2=count(//lst[@name='segments']/lst/str[@name='version'][.='7.1.0'])
[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><lst name="segments"><lst name="_0"><str name="name">_0</str><int name="delCount">1</int><long name="sizeInBytes">1558</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.130Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_1"><str name="name">_1</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.133Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_2"><str name="name">_2</str><int name="delCount">0</int><long name="sizeInBytes">1491</long><int name="size">4</int><date name="age">2017-07-29T09:40:20.182Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst><lst name="_3"><str name="name">_3</str><int name="delCount">0</int><long name="sizeInBytes">1426</long><int name="size">1</int><date name="age">2017-07-29T09:40:20.184Z</date><str name="source">flush</str><str name="version">7.1.0</str></lst></lst>
[junit4] > </response>
[junit4] > request was:qt=/admin/segments&wt=xml
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879)
[junit4] > ... 40 more
[junit4] 2> 1864408 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1864408 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2135946681
[junit4] 2> 1864408 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1864409 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1864409 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1864409 INFO (SUITE-SegmentsInfoRequestHandlerTest-seed#[39B1A0EF0EB982F6]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1864460 INFO (coreCloseExecutor-7875-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@dd4ccfa
[junit4] 2> 1864460 INFO (coreCloseExecutor-7875-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=232049914
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.SegmentsInfoRequestHandlerTest_39B1A0EF0EB982F6-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name=PostingsFormat(name=Memory), id=PostingsFormat(name=Memory)}, docValues:{}, maxPointsInLeafNode=1490, maxMBSortInHeap=5.560805160223049, sim=RandomSimilarity(queryNorm=false): {}, locale=lv, timezone=Canada/Eastern
[junit4] 2> NOTE: Linux 4.10.0-27-generic amd64/Oracle Corporation 1.8.0_141 (64-bit)/cpus=8,threads=1,free=289338704,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrQueryResponse, InfoHandlerTest, TestCustomSort, AlternateDirectoryTest, TestHashPartitioner, TestCollapseQParserPlugin, TestAtomicUpdateErrorCases, TestSolrCLIRunExample, ReplicationFactorTest, TestUpdate, MigrateRouteKeyTest, TestElisionMultitermQuery, TestLegacyNumericUtils, TestFieldTypeResource, CdcrBootstrapTest, SOLR749Test, TestRandomCollapseQParserPlugin, AssignTest, TestPayloadCheckQParserPlugin, TestCursorMarkWithoutUniqueKey, SecurityConfHandlerTest, SuggestComponentTest, TestAnalyzeInfixSuggestions, UpdateRequestProcessorFactoryTest, RecoveryAfterSoftCommitTest, TestHdfsCloudBackupRestore, DistributedFacetPivotSmallAdvancedTest, TestStressRecovery, ZkSolrClientTest, DocValuesTest, CloudExitableDirectoryReaderTest, TestLeaderInitiatedRecoveryThread, TestConfigSetsAPIZkFailure, TestBinaryResponseWriter, TestSlowCompositeReaderWrapper, OverseerCollectionConfigSetProcessorTest, TestNestedDocsSort, TestReqParamsAPI, DistributedQueryComponentCustomSortTest, TestStressCloudBlindAtomicUpdates, BadComponentTest, NodeMutatorTest, MoveReplicaHDFSUlogDirTest, TestUniqueKeyFieldResource, SoftAutoCommitTest, TestCloudJSONFacetJoinDomain, TestSegmentSorting, TestRecoveryHdfs, TestLRUStatsCache, TestLegacyNumericRangeQueryBuilder, TestCoreContainer, PrimUtilsTest, RankQueryTest, TestLRUCache, SchemaVersionSpecificBehaviorTest, TestPullReplica, DistributedTermsComponentTest, ChaosMonkeySafeLeaderWithPullReplicasTest, ScriptEngineTest, TestImpersonationWithHadoopAuth, QueryParsingTest, HdfsRecoveryZkTest, PreAnalyzedFieldManagedSchemaCloudTest, HdfsLockFactoryTest, OpenCloseCoreStressTest, TestRTGBase, TestUseDocValuesAsStored2, ConvertedLegacyTest, MetricUtilsTest, TestClassicSimilarityFactory, SolrCoreMetricManagerTest, TestAuthenticationFramework, BlockJoinFacetSimpleTest, OverseerStatusTest, TestFreeTextSuggestions, TestGraphTermsQParserPlugin, TestCloudRecovery, TestFieldCollectionResource, SpatialFilterTest, TestMacros, DistribDocExpirationUpdateProcessorTest, TestDistributedGrouping, TestValueSourceCache, CacheHeaderTest, FacetPivotSmallTest, DOMUtilTest, TestCharFilters, TestInPlaceUpdatesDistrib, TestCollectionsAPIViaSolrCloudCluster, TestPerFieldSimilarityWithDefaultOverride, CollectionsAPIDistributedZkTest, ResourceLoaderTest, SolrMetricsIntegrationTest, TestEmbeddedSolrServerSchemaAPI, HdfsBasicDistributedZkTest, MoreLikeThisHandlerTest, TestHttpShardHandlerFactory, TestCopyFieldCollectionResource, AutoScalingHandlerTest, RuleEngineTest, ActionThrottleTest, ZkCLITest, TestRandomRequestDistribution, AnalysisAfterCoreReloadTest, SuggesterTSTTest, TermVectorComponentTest, DeleteLastCustomShardedReplicaTest, SolrShardReporterTest, ZkStateReaderTest, TestMiniSolrCloudClusterSSL, SolrCmdDistributorTest, LoggingHandlerTest, TestConfigOverlay, HighlighterTest, TestMinMaxOnMultiValuedField, DistributedFacetExistsSmallTest, CSVRequestHandlerTest, TolerantUpdateProcessorTest, TestBulkSchemaConcurrent, TestFaceting, TermVectorComponentDistributedTest, ZkControllerTest, TestRealTimeGet, TestStressReorder, TestJoin, SpellCheckComponentTest, QueryElevationComponentTest, TestFiltering, TestFoldingMultitermQuery, SuggesterTest, TestTrie, TestCSVLoader, NoCacheHeaderTest, TestPseudoReturnFields, FieldMutatingUpdateProcessorTest, DefaultValueUpdateProcessorTest, SortByFunctionTest, DocValuesMultiTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, TestWriterPerf, TestQueryTypes, TestOmitPositions, XmlUpdateRequestHandlerTest, DocumentBuilderTest, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, IndexSchemaTest, TestCSVResponseWriter, JsonLoaderTest, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, HighlighterConfigTest, UpdateParamsTest, ResponseLogComponentTest, MultiTermTest, TestBinaryField, MinimalSchemaTest, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestPhraseSuggestions, TestXIncludeConfig, TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory, TestBM25SimilarityFactory, TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest, ClusterStateTest, TestSolrJ, TestDocumentBuilder, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, CursorPagingTest, DistributedIntervalFacetingTest, TestCrossCoreJoin, TestSimpleTrackingShardHandler, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CleanupOldIndexTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, CreateCollectionCleanupTest, DeleteInactiveReplicaTest, DeleteReplicaTest, DistribJoinFromCollectionTest, DistributedVersionInfoTest, LeaderElectionContextKeyTest, LeaderFailoverAfterPartitionTest, MissingSegmentRecoveryTest, MoveReplicaHDFSTest, ReplaceNodeTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SimpleCollectionCreateDeleteTest, SolrCLIZkUtilsTest, SolrCloudExampleTest, TestCloudPseudoReturnFields, TestClusterProperties, TestDistribDocBasedVersion, TestDownShardTolerantSearch, TestExclusionRuleCollectionAccess, TestLeaderElectionWithEmptyReplica, TestLocalFSCloudBackupRestore, TestPrepRecovery, TriLevelCompositeIdRoutingTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsThreadLeakTest, CachingDirectoryFactoryTest, ConfigureRecoveryStrategyTest, HdfsDirectoryFactoryTest, TestDynamicLoading, TestSolrCoreSnapshots, TestHdfsBackupRestoreCore, TestSQLHandlerNonCloud, TestSolrConfigHandlerCloud, CoreMergeIndexesAdminHandlerTest, SegmentsInfoRequestHandlerTest]
[junit4] Completed [590/726 (2!)] on J1 in 0.45s, 3 tests, 1 error <<< FAILURES!
[...truncated 43793 lines...]