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 2019/07/13 18:11:52 UTC
[JENKINS] Lucene-Solr-8.x-Solaris (64bit/jdk1.8.0) - Build # 234 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Solaris/234/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.schema.TestUseDocValuesAsStored.testDuplicateMultiValued
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([A542CABFE8EDB91C:4B9FDE9F265C4FA0]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:947)
at org.apache.solr.schema.TestUseDocValuesAsStored.doTest(TestUseDocValuesAsStored.java:367)
at org.apache.solr.schema.TestUseDocValuesAsStored.testDuplicateMultiValued(TestUseDocValuesAsStored.java:172)
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:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
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:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
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=//arr[@name='enums_dvo']/str[.='Not Available']
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="11" start="0"><doc><str name="id">myid1</str></doc><doc><str name="id">myid</str></doc><doc><str name="id">1</str><arr name="test_ss_dvo"><str>X</str><str>Y</str></arr></doc><doc><str name="id">2</str><arr name="test_ss_dv"><str>X</str><str>X</str><str>Y</str></arr></doc><doc><str name="id">3</str><arr name="test_ss_dvo2"><str>X</str><str>Y</str></arr></doc><doc><str name="id">4</str><arr name="test_is_dvo"><int>-666</int><int>42</int></arr></doc><doc><str name="id">5</str><arr name="test_fs_dvo"><float>-66.666</float><float>4.2</float></arr></doc><doc><str name="id">6</str><arr name="test_ls_dvo"><long>-6666666</long><long>420</long></arr></doc><doc><str name="id">7</str><arr name="test_ds_dvo"><double>-6.6666E-5</double><double>0.0042</double></arr></doc><doc><str name="id">8</str><arr name="test_dts_dvo"><date>1999-12-31T23:59:59Z</date><date>2016-07-04T03:02:01Z</date></arr></doc></result>
</response>
request was:q=*:*&fl=*&wt=xml
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:940)
... 41 more
Build Log:
[...truncated 13270 lines...]
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] 2> 318877 INFO (SUITE-TestUseDocValuesAsStored-seed#[A542CABFE8EDB91C]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/init-core-data-001
[junit4] 2> 318878 WARN (SUITE-TestUseDocValuesAsStored-seed#[A542CABFE8EDB91C]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=82 numCloses=82
[junit4] 2> 318878 INFO (SUITE-TestUseDocValuesAsStored-seed#[A542CABFE8EDB91C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 318879 INFO (SUITE-TestUseDocValuesAsStored-seed#[A542CABFE8EDB91C]-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> 318882 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOnEmptyIndex
[junit4] 2> 318885 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 318890 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 318896 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-non-stored-docvalues.xml instead
[junit4] 2> 318897 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues
[junit4] 2> 318902 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 318911 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1/conf/managed-schema
[junit4] 2> 318914 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml to /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml.bak
[junit4] 2> 319612 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 319618 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3841bf74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 319618 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3841bf74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 319620 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@19edc83b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 319620 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@19edc83b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 319637 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 319637 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 319660 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 319665 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 319666 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 319676 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 319685 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues
[junit4] 2> 319692 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 319692 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1, trusted=true
[junit4] 2> 319693 INFO (coreLoadExecutor-1450-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@11d60489
[junit4] 2> 319693 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/init-core-data-001/]
[junit4] 2> 319695 INFO (coreLoadExecutor-1450-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=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4173488147485306]
[junit4] 2> 319698 WARN (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 319734 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 319734 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 319735 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=10.5048828125, floorSegmentMB=1.8330078125, forceMergeDeletesPctAllowed=2.379525845236362, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5723516674810656, deletesPctAllowed=31.14263474676688
[junit4] 2> 319735 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@70be501b[collection1] main]
[junit4] 2> 319736 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-001/collection1/conf
[junit4] 2> 319736 INFO (coreLoadExecutor-1450-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 319737 INFO (searcherExecutor-1451-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@70be501b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 319739 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 319739 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 319740 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 1
[junit4] 2> 319740 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 319740 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4d280cf7 commitCommandVersion:0
[junit4] 2> 319744 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@40d37f67[collection1] main]
[junit4] 2> 319744 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 319745 INFO (searcherExecutor-1451-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@40d37f67[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 319745 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4
[junit4] 2> 319745 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319745 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319745 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319745 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 13
[junit4] 2> 319759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 319760 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 319760 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4d280cf7 commitCommandVersion:0
[junit4] 2> 319769 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@32c089ba[collection1] main]
[junit4] 2> 319769 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 319771 INFO (searcherExecutor-1451-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@32c089ba[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035553846}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 319771 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 11
[junit4] 2> 319771 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 319772 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 319772 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=test_nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 319772 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*,test_nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 319773 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0
[junit4] 2> 319773 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 319773 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4d280cf7 commitCommandVersion:0
[junit4] 2> 319780 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@13af730[collection1] main]
[junit4] 2> 319781 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 319781 INFO (searcherExecutor-1451-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13af730[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035553859}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 319782 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 9
[junit4] 2> 319783 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 319783 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 319783 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 0
[junit4] 2> 319783 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 319783 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1266277782
[junit4] 2> 319784 INFO (coreCloseExecutor-1455-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@72c3e7e2
[junit4] 2> 319784 INFO (coreCloseExecutor-1455-thread-1) [ x:collection1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=72c3e7e2
[junit4] 2> 319784 INFO (coreCloseExecutor-1455-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@63c667f: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2364fff4
[junit4] 2> 319791 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 319791 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6945319: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6052cc87
[junit4] 2> 319795 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 319795 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@58371746: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7a7b2066
[junit4] 2> 319797 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 319797 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@409e5c0a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4472c762
[junit4] 2> 319799 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOnEmptyIndex
[junit4] 2> 319802 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleSearchResults
[junit4] 2> 319804 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 319810 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 319815 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-non-stored-docvalues.xml instead
[junit4] 2> 319816 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues
[junit4] 2> 319820 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 319821 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1/conf/managed-schema
[junit4] 2> 319822 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml to /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml.bak
[junit4] 2> 321563 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 321565 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@537556e0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 321565 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@537556e0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 321572 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3e480f5b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 321572 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3e480f5b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 321603 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 321603 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 321633 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 321642 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 321642 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 321657 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 321665 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues
[junit4] 2> 321670 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 321670 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1, trusted=true
[junit4] 2> 321670 INFO (coreLoadExecutor-1465-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@11d60489
[junit4] 2> 321671 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/init-core-data-001/]
[junit4] 2> 321673 WARN (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 321733 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 321733 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 321734 INFO (coreLoadExecutor-1465-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=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4173488147485306]
[junit4] 2> 321736 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1701bd18[collection1] main]
[junit4] 2> 321737 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-002/collection1/conf
[junit4] 2> 321737 INFO (coreLoadExecutor-1465-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 321738 INFO (searcherExecutor-1466-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1701bd18[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.3.0):C1:[diagnostics={java.vendor=Oracle Corporation, os=SunOS, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035553859}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 321740 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 321742 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 1
[junit4] 2> 321742 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid2]} 0 0
[junit4] 2> 321743 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid3]} 0 0
[junit4] 2> 321743 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid4]} 0 0
[junit4] 2> 321743 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid5]} 0 0
[junit4] 2> 321743 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid6]} 0 0
[junit4] 2> 321744 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 321744 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@48adf576 commitCommandVersion:0
[junit4] 2> 321821 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c612d5b[collection1] main]
[junit4] 2> 321821 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 321821 INFO (searcherExecutor-1466-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c612d5b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.3.0):C1:[diagnostics={java.vendor=Oracle Corporation, os=SunOS, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035553859}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.3.0):C6:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035555845}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 321821 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 77
[junit4] 2> 321827 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=6 status=0 QTime=5
[junit4] 2> 321830 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 321830 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 0
[junit4] 2> 321830 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 321830 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1517740171
[junit4] 2> 321831 INFO (coreCloseExecutor-1470-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@651d21d5
[junit4] 2> 321831 INFO (coreCloseExecutor-1470-thread-1) [ x:collection1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=651d21d5
[junit4] 2> 321832 INFO (coreCloseExecutor-1470-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@9ad45f3: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@67204a94
[junit4] 2> 321859 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 321860 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a2b7a6d: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5df1d20d
[junit4] 2> 321870 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 321870 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f02b341: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@7a7b2066
[junit4] 2> 321874 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 321874 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@44caf6d4: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@4472c762
[junit4] 2> 321879 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleSearchResults
[junit4] 2> 321897 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandomSingleAndMultiValued
[junit4] 2> 321901 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 321911 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 321920 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-non-stored-docvalues.xml instead
[junit4] 2> 321923 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues
[junit4] 2> 321929 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 321930 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1/conf/managed-schema
[junit4] 2> 321931 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml to /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml.bak
[junit4] 2> 322549 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 322550 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7d991cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 322550 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7d991cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 322553 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7d10417d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 322553 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7d10417d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 322570 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 322570 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 322593 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 322601 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 322601 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@11d60489
[junit4] 2> 322612 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.3.0
[junit4] 2> 322621 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues
[junit4] 2> 322628 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id
[junit4] 2> 322628 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1, trusted=true
[junit4] 2> 322628 INFO (coreLoadExecutor-1480-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@11d60489
[junit4] 2> 322628 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/init-core-data-001/]
[junit4] 2> 322630 WARN (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 322671 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 322671 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 322672 INFO (coreLoadExecutor-1480-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=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4173488147485306]
[junit4] 2> 322674 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@aa2fbd4[collection1] main]
[junit4] 2> 322674 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.schema.TestUseDocValuesAsStored_A542CABFE8EDB91C-001/tempDir-003/collection1/conf
[junit4] 2> 322675 INFO (coreLoadExecutor-1480-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 322676 INFO (searcherExecutor-1481-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@aa2fbd4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.3.0):C1:[diagnostics={java.vendor=Oracle Corporation, os=SunOS, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035553859}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.3.0):C6:[diagnostics={java.vendor=Oracle Corporation, os=SunOS, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035555845}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322677 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 322678 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 322680 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 3
[junit4] 2> 322681 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 322681 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322682 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322695 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@29c33b34[collection1] main]
[junit4] 2> 322695 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322696 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@29c33b34[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322697 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 15
[junit4] 2> 322698 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_s_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322707 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_s_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322709 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322715 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322715 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_s_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322716 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322716 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 322717 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322717 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322728 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2ddd355d[collection1] main]
[junit4] 2> 322729 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322730 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2ddd355d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322730 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13
[junit4] 2> 322731 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322732 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322733 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322734 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322734 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322735 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0
[junit4] 2> 322736 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 322737 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322737 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322745 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2fcbb21[collection1] main]
[junit4] 2> 322746 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322747 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2fcbb21[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322747 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 10
[junit4] 2> 322747 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322748 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322748 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322749 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322749 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322749 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=3 status=0 QTime=0
[junit4] 2> 322750 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 322750 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322750 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322761 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@413eb907[collection1] main]
[junit4] 2> 322762 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322763 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@413eb907[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556837}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322763 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 12
[junit4] 2> 322764 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322765 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322765 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322766 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322767 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322767 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=4 status=0 QTime=0
[junit4] 2> 322769 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 322769 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322769 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322780 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2210331e[collection1] main]
[junit4] 2> 322781 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322782 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2210331e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556837}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_7(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556856}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322782 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13
[junit4] 2> 322783 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322783 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322784 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322784 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322785 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322785 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=5 status=0 QTime=0
[junit4] 2> 322787 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 322787 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322787 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322800 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15cdd8f2[collection1] main]
[junit4] 2> 322800 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322801 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15cdd8f2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556837}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_7(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556856}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_8(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556874}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322801 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13
[junit4] 2> 322801 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322802 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322802 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=*dvo&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322803 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322804 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322805 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=6 status=0 QTime=0
[junit4] 2> 322807 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 322807 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322808 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322821 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@32d1c797[collection1] main]
[junit4] 2> 322822 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322822 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@32d1c797[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556837}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_7(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556856}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_8(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556874}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_9(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556894}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322823 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 15
[junit4] 2> 322823 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322824 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322825 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=*_dv&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322825 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322826 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322827 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=7 status=0 QTime=0
[junit4] 2> 322828 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 322829 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322829 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322840 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@47c69aae[collection1] main]
[junit4] 2> 322852 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322853 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@47c69aae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556804}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556823}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556837}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_7(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556856}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_8(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556874}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_9(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556894}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_a(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556916}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 322853 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 24
[junit4] 2> 322854 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322854 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2,*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322854 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=*vo2&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322859 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322860 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2,fakeFieldName&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 322860 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=8 status=0 QTime=0
[junit4] 2> 322862 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 322862 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 322862 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4fc1f6d9 commitCommandVersion:0
[junit4] 2> 322880 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@31aa2ae5[collection1] main]
[junit4] 2> 322881 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[A542CABFE8EDB91C]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 322882 INFO (searcherExecutor-1481-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@31aa2ae5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=1563035556768}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.3.0):C1:[diagnostics={os=SunOS, java.vendor=Oracle Corporation, java.version=1.8.0_201, java.vm.version=25.201-b09, lucene.version=8.3.0, os.arch=amd64, java.runtime.version=1.8.0_201-b09, source=flush, os.version=5.11, timestamp=15630355
[...truncated too long message...]
ting 5 suites with 2 JVMs.
[junit4]
[junit4] Started J1 PID(9446@serv1-vm3).
[junit4] Started J0 PID(9447@serv1-vm3).
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] OK 5.19s J1 | TestUseDocValuesAsStored.testOnEmptyIndex
[junit4] OK 0.57s J1 | TestUseDocValuesAsStored.testMultipleSearchResults
[junit4] OK 5.72s J1 | TestUseDocValuesAsStored.testRandomSingleAndMultiValued
[junit4] OK 0.55s J1 | TestUseDocValuesAsStored.testManagedSchema
[junit4] OK 0.56s J1 | TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse
[junit4] OK 2.28s J1 | TestUseDocValuesAsStored.testDuplicateMultiValued
[junit4] OK 0.38s J1 | TestUseDocValuesAsStored.testMultivaluedOrdering
[junit4] Completed [1/5] on J1 in 17.96s, 7 tests
[junit4]
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] OK 4.89s J0 | TestUseDocValuesAsStored.testOnEmptyIndex
[junit4] OK 1.57s J0 | TestUseDocValuesAsStored.testMultipleSearchResults
[junit4] OK 5.35s J0 | TestUseDocValuesAsStored.testRandomSingleAndMultiValued
[junit4] OK 0.73s J0 | TestUseDocValuesAsStored.testManagedSchema
[junit4] OK 0.46s J0 | TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse
[junit4] OK 0.89s J0 | TestUseDocValuesAsStored.testDuplicateMultiValued
[junit4] OK 2.66s J0 | TestUseDocValuesAsStored.testMultivaluedOrdering
[junit4] Completed [2/5] on J0 in 19.14s, 7 tests
[junit4]
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] OK 0.84s J1 | TestUseDocValuesAsStored.testOnEmptyIndex
[junit4] OK 0.76s J1 | TestUseDocValuesAsStored.testMultipleSearchResults
[junit4] OK 3.96s J1 | TestUseDocValuesAsStored.testRandomSingleAndMultiValued
[junit4] OK 0.66s J1 | TestUseDocValuesAsStored.testManagedSchema
[junit4] OK 1.33s J1 | TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse
[junit4] OK 0.72s J1 | TestUseDocValuesAsStored.testDuplicateMultiValued
[junit4] OK 0.97s J1 | TestUseDocValuesAsStored.testMultivaluedOrdering
[junit4] Completed [3/5] on J1 in 9.29s, 7 tests
[junit4]
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] OK 1.13s J0 | TestUseDocValuesAsStored.testOnEmptyIndex
[junit4] OK 1.15s J0 | TestUseDocValuesAsStored.testMultipleSearchResults
[junit4] OK 3.88s J0 | TestUseDocValuesAsStored.testRandomSingleAndMultiValued
[junit4] OK 1.02s J0 | TestUseDocValuesAsStored.testManagedSchema
[junit4] OK 0.67s J0 | TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse
[junit4] OK 0.94s J0 | TestUseDocValuesAsStored.testDuplicateMultiValued
[junit4] OK 3.00s J0 | TestUseDocValuesAsStored.testMultivaluedOrdering
[junit4] Completed [4/5] on J0 in 12.08s, 7 tests
[junit4]
[junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored
[junit4] OK 0.50s J1 | TestUseDocValuesAsStored.testOnEmptyIndex
[junit4] OK 1.21s J1 | TestUseDocValuesAsStored.testMultipleSearchResults
[junit4] OK 4.54s J1 | TestUseDocValuesAsStored.testRandomSingleAndMultiValued
[junit4] OK 0.57s J1 | TestUseDocValuesAsStored.testManagedSchema
[junit4] OK 0.67s J1 | TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse
[junit4] OK 1.08s J1 | TestUseDocValuesAsStored.testDuplicateMultiValued
[junit4] OK 0.32s J1 | TestUseDocValuesAsStored.testMultivaluedOrdering
[junit4] Completed [5/5] on J1 in 9.09s, 7 tests
[junit4]
[junit4] JVM J0: 0.70 .. 32.72 = 32.03s
[junit4] JVM J1: 0.69 .. 38.15 = 37.45s
[junit4] Execution time total: 38 seconds
[junit4] Tests summary: 5 suites, 35 tests
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J0/temp])
[junit4] Could not remove temporary path: /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp])
[echo] 5 slowest tests:
[junit4:tophints] 281.23s | org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest
[junit4:tophints] 231.81s | org.apache.solr.cloud.api.collections.ShardSplitTest
[junit4:tophints] 210.82s | org.apache.solr.search.facet.TestJsonFacets
[junit4:tophints] 166.83s | org.apache.solr.cloud.CollectionsAPISolrJTest
[junit4:tophints] 117.54s | org.apache.solr.update.SoftAutoCommitTest
-check-totals:
test-nocompile:
BUILD SUCCESSFUL
Total time: 40 seconds
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.schema.TestUseDocValuesAsStored
[repro] Exiting with code 0
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2805)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2684)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2665)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3052)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to Solaris VBOX
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1743)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:957)
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2663)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1843)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3054)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1074)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2663)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:248)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:79)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1843)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/*_pid*.log". Configuration error?
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=d91900a4a271829325a948aff874301979aba202, workspace=/export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris
[WARNINGS] Computing warning deltas based on reference build #233
Recording test results
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/export/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2