Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/3241/ Java: 32bit/jdk1.8.0_121 -client -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults Error Message: mismatch: 'myid1'!='myid' @ response/docs/[0]/id Stack Trace: java.lang.RuntimeException: mismatch: 'myid1'!='myid' @ response/docs/[0]/id at __randomizedtesting.SeedInfo.seed([FB71B0C6134597DE:C95BB758EBBBB307]:0) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:969) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:916) at org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults(TestUseDocValuesAsStored.java:243) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 13135 lines...] [junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001 [junit4] 2> 1895007 INFO (SUITE-TestUseDocValuesAsStored-seed#[FB71B0C6134597DE]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields [junit4] 2> 1895008 INFO (SUITE-TestUseDocValuesAsStored-seed#[FB71B0C6134597DE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1895009 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultivaluedOrdering [junit4] 2> 1895011 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1895021 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895028 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] 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> 1895033 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 1895041 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895042 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 1895078 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 1895080 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1895103 WARN (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895108 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895108 WARN (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895114 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895114 WARN (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895114 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895128 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895138 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 1895153 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895153 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1, trusted=true [junit4] 2> 1895154 WARN (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895154 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895154 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1895154 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001/] [junit4] 2> 1895157 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=69.494140625, floorSegmentMB=0.6875, forceMergeDeletesPctAllowed=8.931025092466577, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1895175 WARN (coreLoadExecutor-6617-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> 1895224 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1895224 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1895225 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7911055295154367] [junit4] 2> 1895226 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@11a004b[collection1] main] [junit4] 2> 1895226 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-001/collection1/conf [junit4] 2> 1895227 INFO (coreLoadExecutor-6617-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1895227 INFO (searcherExecutor-6618-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@11a004b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1895228 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1895229 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1895229 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] 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> 1895230 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1 [junit4] 2> 1895234 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0 [junit4] 2> 1895235 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0 [junit4] 2> 1895236 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0 [junit4] 2> 1895237 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1895237 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@238447 [junit4] 2> 1895362 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@eb9481[collection1] main] [junit4] 2> 1895363 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1895363 INFO (searcherExecutor-6618-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@eb9481[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4)))} [junit4] 2> 1895364 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 127 [junit4] 2> 1895365 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_mvt_dvt_st_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895366 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_mvt_dvt_sf_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895366 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_mvt_dvf_st_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895367 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_mvt_dvu_st_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895367 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1895367 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=5184720 [junit4] 2> 1895367 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1895368 INFO (coreCloseExecutor-6622-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1422a0d [junit4] 2> 1895369 INFO (coreCloseExecutor-6622-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 1895372 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 1895374 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultivaluedOrdering [junit4] 2> 1895377 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testUseDocValuesAsStoredFalse [junit4] 2> 1895379 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1895389 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895396 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] 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> 1895399 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 1895408 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895409 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1/conf/managed-schema [junit4] 2> 1895443 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 1895445 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1895466 WARN (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895470 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895470 WARN (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895476 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895476 WARN (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895476 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895489 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895498 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 1895507 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895507 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1, trusted=true [junit4] 2> 1895508 WARN (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895508 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895508 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1895508 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001/] [junit4] 2> 1895512 WARN (coreLoadExecutor-6629-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> 1895557 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1895557 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1895559 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=69.494140625, floorSegmentMB=0.6875, forceMergeDeletesPctAllowed=8.931025092466577, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1895562 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@180b347[collection1] main] [junit4] 2> 1895562 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-002/collection1/conf [junit4] 2> 1895563 INFO (coreLoadExecutor-6629-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1895563 INFO (searcherExecutor-6630-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@180b347[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4)))} [junit4] 2> 1895564 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1895565 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid]} 0 1 [junit4] 2> 1895566 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1895566 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3ce828 [junit4] 2> 1895695 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@162895d[collection1] main] [junit4] 2> 1895696 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1895696 INFO (searcherExecutor-6630-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@162895d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4) Uninverting(_1(6.6.0):C1)))} [junit4] 2> 1895696 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 130 [junit4] 2> 1895697 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895698 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895699 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=id,nonstored_dv_*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895700 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=id,nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1895700 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1895700 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=33129333 [junit4] 2> 1895700 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1895700 INFO (coreCloseExecutor-6634-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1a95a1a [junit4] 2> 1895702 INFO (coreCloseExecutor-6634-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 1895705 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 1895707 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testUseDocValuesAsStoredFalse [junit4] 2> 1895709 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleSearchResults [junit4] 2> 1895712 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1895726 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895734 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] 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> 1895737 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 1895745 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895747 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1/conf/managed-schema [junit4] 2> 1895778 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 1895780 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1895803 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895807 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895808 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895813 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895813 WARN (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895814 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895826 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1895835 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 1895844 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1895844 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1, trusted=true [junit4] 2> 1895844 WARN (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1895845 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1895845 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1895845 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001/] [junit4] 2> 1895848 WARN (coreLoadExecutor-6641-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> 1895892 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1895892 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1895894 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=69.494140625, floorSegmentMB=0.6875, forceMergeDeletesPctAllowed=8.931025092466577, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1895897 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bb4638[collection1] main] [junit4] 2> 1895898 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-003/collection1/conf [junit4] 2> 1895898 INFO (coreLoadExecutor-6641-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1895898 INFO (searcherExecutor-6642-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1bb4638[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4) Uninverting(_1(6.6.0):C1)))} [junit4] 2> 1895899 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1895901 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 1 [junit4] 2> 1895902 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid2]} 0 0 [junit4] 2> 1895902 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid3]} 0 0 [junit4] 2> 1895904 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid4]} 0 0 [junit4] 2> 1895904 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid5]} 0 0 [junit4] 2> 1895905 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid6]} 0 0 [junit4] 2> 1895905 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1895905 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9c9e71 [junit4] 2> 1896072 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f056e8[collection1] main] [junit4] 2> 1896073 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896073 INFO (searcherExecutor-6642-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f056e8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4) Uninverting(_1(6.6.0):C1) Uninverting(_2(6.6.0):C6)))} [junit4] 2> 1896073 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 167 [junit4] 2> 1896075 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=7 status=0 QTime=1 [junit4] 2> 1896076 ERROR (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=mismatch: 'myid1'!='myid' @ response/docs/[0]/id [junit4] 2> expected =/response/docs==[{'id':'myid1','test_is_dvo':[101,102,103]},{'id':'myid2','test_is_dvo':[201,202]},{'id':'myid3','test_is_dvo':[301,302,303,304]},{'id':'myid4','test_s_dvo':'hello','test_is_dvo':[401,402]},{'id':'myid5'},{'id':'myid6','test_s_dvo':'hello'}] [junit4] 2> response = { [junit4] 2> "responseHeader":{ [junit4] 2> "status":0, [junit4] 2> "QTime":1}, [junit4] 2> "response":{"numFound":7,"start":0,"docs":[ [junit4] 2> { [junit4] 2> "id":"myid"}, [junit4] 2> { [junit4] 2> "id":"myid1", [junit4] 2> "test_is_dvo":[101, [junit4] 2> 102, [junit4] 2> 103]}, [junit4] 2> { [junit4] 2> "id":"myid2", [junit4] 2> "test_is_dvo":[201, [junit4] 2> 202]}, [junit4] 2> { [junit4] 2> "id":"myid3", [junit4] 2> "test_is_dvo":[301, [junit4] 2> 302, [junit4] 2> 303, [junit4] 2> 304]}, [junit4] 2> { [junit4] 2> "id":"myid4", [junit4] 2> "test_s_dvo":"hello", [junit4] 2> "test_is_dvo":[401, [junit4] 2> 402]}, [junit4] 2> { [junit4] 2> "id":"myid5"}, [junit4] 2> { [junit4] 2> "id":"myid6", [junit4] 2> "test_s_dvo":"hello"}] [junit4] 2> }} [junit4] 2> [junit4] 2> request = q=id:myid*&fl=*&wt=xml [junit4] 2> 1896077 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1896077 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30392710 [junit4] 2> 1896077 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1896080 INFO (coreCloseExecutor-6646-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1c24ee8 [junit4] 2> 1896081 INFO (coreCloseExecutor-6646-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 1896086 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 1896087 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleSearchResults [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestUseDocValuesAsStored -Dtests.method=testMultipleSearchResults -Dtests.seed=FB71B0C6134597DE -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=und -Dtests.timezone=Etc/GMT-13 -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.38s J2 | TestUseDocValuesAsStored.testMultipleSearchResults <<< [junit4] > Throwable #1: java.lang.RuntimeException: mismatch: 'myid1'!='myid' @ response/docs/[0]/id [junit4] > at __randomizedtesting.SeedInfo.seed([FB71B0C6134597DE:C95BB758EBBBB307]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:969) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:916) [junit4] > at org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults(TestUseDocValuesAsStored.java:243) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1896091 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOnEmptyIndex [junit4] 2> 1896093 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1896103 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1896110 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896113 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 1896127 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1896128 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1/conf/managed-schema [junit4] 2> 1896152 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 1896154 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1896176 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896181 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896181 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896186 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896186 WARN (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896186 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896198 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1896208 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 1896217 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1896217 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1, trusted=true [junit4] 2> 1896217 WARN (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896217 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896217 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1896217 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001/] [junit4] 2> 1896221 WARN (coreLoadExecutor-6653-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> 1896267 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1896267 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1896269 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=69.494140625, floorSegmentMB=0.6875, forceMergeDeletesPctAllowed=8.931025092466577, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1896273 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1312936[collection1] main] [junit4] 2> 1896274 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-004/collection1/conf [junit4] 2> 1896274 INFO (coreLoadExecutor-6653-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1896274 INFO (searcherExecutor-6654-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1312936[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C4) Uninverting(_1(6.6.0):C1) Uninverting(_2(6.6.0):C6)))} [junit4] 2> 1896276 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1896277 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1896277 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896278 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896278 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@140239d [junit4] 2> 1896289 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4fc074[collection1] main] [junit4] 2> 1896290 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896290 INFO (searcherExecutor-6654-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4fc074[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1896291 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13 [junit4] 2> 1896292 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1896292 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1896292 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896293 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896294 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 1896294 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1896295 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1896295 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896295 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896295 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896296 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@140239d [junit4] 2> 1896407 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@fcbc4f[collection1] main] [junit4] 2> 1896408 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896408 INFO (searcherExecutor-6654-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@fcbc4f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.6.0):C1)))} [junit4] 2> 1896408 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 112 [junit4] 2> 1896409 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896409 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896409 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896410 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] 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> 1896411 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 1896411 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896411 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@140239d [junit4] 2> 1896481 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2d10f5[collection1] main] [junit4] 2> 1896482 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896482 INFO (searcherExecutor-6654-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2d10f5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.6.0):C1)))} [junit4] 2> 1896482 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 71 [junit4] 2> 1896483 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896484 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1896484 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=31510805 [junit4] 2> 1896484 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1896484 INFO (coreCloseExecutor-6658-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@211130 [junit4] 2> 1896485 INFO (coreCloseExecutor-6658-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 1896489 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 1896490 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOnEmptyIndex [junit4] 2> 1896493 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandomSingleAndMultiValued [junit4] 2> 1896496 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1896506 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1896513 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896516 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 1896525 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1896526 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1/conf/managed-schema [junit4] 2> 1896561 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 1896563 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 1896585 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896589 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896589 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896595 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896595 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896595 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896608 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 1896623 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 1896632 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 1896632 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1, trusted=true [junit4] 2> 1896633 WARN (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 1896633 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@187282d [junit4] 2> 1896633 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1896633 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/init-core-data-001/] [junit4] 2> 1896637 WARN (coreLoadExecutor-6665-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> 1896679 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1896679 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1896681 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=69.494140625, floorSegmentMB=0.6875, forceMergeDeletesPctAllowed=8.931025092466577, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1896683 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b99cb6[collection1] main] [junit4] 2> 1896683 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-005/collection1/conf [junit4] 2> 1896683 INFO (coreLoadExecutor-6665-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1896684 INFO (searcherExecutor-6666-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b99cb6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.6.0):C1)))} [junit4] 2> 1896685 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1896686 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1896686 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896688 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1 [junit4] 2> 1896688 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896689 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1896792 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c315b5[collection1] main] [junit4] 2> 1896793 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896793 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c315b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1)))} [junit4] 2> 1896794 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 105 [junit4] 2> 1896795 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896797 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896798 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896799 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896800 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896801 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896805 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 2 [junit4] 2> 1896805 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896806 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1896916 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@619478[collection1] main] [junit4] 2> 1896917 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1896917 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@619478[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1)))} [junit4] 2> 1896917 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 111 [junit4] 2> 1896919 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896920 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896920 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896922 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1896923 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1896924 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 1896928 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 2 [junit4] 2> 1896929 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1896929 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1897074 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a2c635[collection1] main] [junit4] 2> 1897074 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1897074 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a2c635[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1)))} [junit4] 2> 1897075 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 146 [junit4] 2> 1897076 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1897082 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897086 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897089 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897094 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897098 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=3 status=0 QTime=0 [junit4] 2> 1897103 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 1 [junit4] 2> 1897104 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1897104 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1897228 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1170efb[collection1] main] [junit4] 2> 1897229 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1897229 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1170efb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1)))} [junit4] 2> 1897230 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 126 [junit4] 2> 1897232 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1897236 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo,*&wt=xml} hits=1 status=0 QTime=2 [junit4] 2> 1897238 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897239 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897241 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1897242 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 1897244 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0 [junit4] 2> 1897244 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1897244 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1897366 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@27cf24[collection1] main] [junit4] 2> 1897368 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1897368 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@27cf24[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1)))} [junit4] 2> 1897368 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 124 [junit4] 2> 1897370 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_fs_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897371 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_fs_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897373 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897374 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897375 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_fs_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897376 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=5 status=0 QTime=0 [junit4] 2> 1897382 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 2 [junit4] 2> 1897382 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1897383 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1897527 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6f5efd[collection1] main] [junit4] 2> 1897528 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1897528 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6f5efd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1) Uninverting(_a(6.6.0):C1)))} [junit4] 2> 1897529 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 146 [junit4] 2> 1897530 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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=1 [junit4] 2> 1897534 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897538 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897542 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897545 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897552 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=6 status=0 QTime=0 [junit4] 2> 1897561 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 2 [junit4] 2> 1897562 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1897562 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3908b3 [junit4] 2> 1897678 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ab06ea[collection1] main] [junit4] 2> 1897679 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1897680 INFO (searcherExecutor-6666-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ab06ea[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1) Uninverting(_a(6.6.0):C1) Uninverting(_b(6.6.0):C1)))} [junit4] 2> 1897680 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 118 [junit4] 2> 1897681 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_ss_dv&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897683 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_ss_dv,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1897684 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897685 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] 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> 1897687 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_ss_dv,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1 [...truncated too long message...] conf [junit4] 2> 1938819 INFO (coreLoadExecutor-6677-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1938819 INFO (searcherExecutor-6678-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@ef4816[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7e(6.6.0):C1) Uninverting(_7f(6.6.0):C1) Uninverting(_7g(6.6.0):C1) Uninverting(_7h(6.6.0):C1) Uninverting(_7i(6.6.0):C1) Uninverting(_7j(6.6.0):C1) Uninverting(_7k(6.6.0):C1) Uninverting(_7l(6.6.0):C1) Uninverting(_7m(6.6.0):C1)))} [junit4] 2> 1938821 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1938822 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-006/collection1/conf/managed-schema [junit4] 2> 1938836 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001/tempDir-006/collection1/conf/managed-schema [junit4] 2> 1938841 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1938842 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] 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> 1938843 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 0 [junit4] 2> 1938843 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1938843 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@119f861 [junit4] 2> 1939627 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@d62b51[collection1] main] [junit4] 2> 1939628 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1939628 INFO (searcherExecutor-6678-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@d62b51[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7n(6.6.0):C1)))} [junit4] 2> 1939632 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 789 [junit4] 2> 1939633 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1939634 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1939634 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14661550 [junit4] 2> 1939634 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1939634 INFO (coreCloseExecutor-6682-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b3fbbd [junit4] 2> 1939635 INFO (coreCloseExecutor-6682-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 1939639 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 1939642 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[FB71B0C6134597DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testManagedSchema [junit4] 2> 1939644 INFO (SUITE-TestUseDocValuesAsStored-seed#[FB71B0C6134597DE]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestUseDocValuesAsStored_FB71B0C6134597DE-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=699, maxMBSortInHeap=5.0422724433145465, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=und, timezone=Etc/GMT-13 [junit4] 2> NOTE: Linux 4.4.0-72-generic i386/Oracle Corporation 1.8.0_121 (32-bit)/cpus=12,threads=1,free=143586816,total=395575296 [junit4] 2> NOTE: All tests run in this JVM: [PreAnalyzedFieldTest, SuggesterTSTTest, SolrMetricsIntegrationTest, TestZkChroot, TermVectorComponentDistributedTest, TlogReplayBufferedWhileIndexingTest, SolrXmlInZkTest, HdfsChaosMonkeySafeLeaderTest, TestRandomFlRTGCloud, TestBulkSchemaAPI, FullSolrCloudDistribCmdsTest, TestSizeLimitedDistributedMap, BinaryUpdateRequestHandlerTest, HdfsSyncSliceTest, CircularListTest, TestExportWriter, TestDownShardTolerantSearch, CheckHdfsIndexTest, HardAutoCommitTest, TestLMJelinekMercerSimilarityFactory, PluginInfoTest, DistributedQueryComponentOptimizationTest, TestCoreDiscovery, TestPhraseSuggestions, TestDefaultStatsCache, TestMacroExpander, TestUninvertingReader, ConfigureRecoveryStrategyTest, RequestHandlersTest, SolrCoreMetricManagerTest, TestCollationFieldDocValues, BadIndexSchemaTest, TestSolrCLIRunExample, DOMUtilTest, TestBinaryField, TestSmileRequest, RecoveryZkTest, TestDFRSimilarityFactory, AutoCommitTest, AsyncCallRequestStatusResponseTest, TestConfigSetsAPI, TestPostingsSolrHighlighter, TestTrieFacet, DebugComponentTest, AnalyticsMergeStrategyTest, ShardSplitTest, CoreAdminHandlerTest, TestCloudInspectUtil, BadComponentTest, TestSchemaSimilarityResource, QueryParsingTest, TestInfoStreamLogging, NoCacheHeaderTest, TestJsonRequest, HdfsLockFactoryTest, BasicDistributedZk2Test, TestTrackingShardHandlerFactory, SimpleFacetsTest, CollectionTooManyReplicasTest, SolrCoreCheckLockOnStartupTest, HdfsRecoverLeaseTest, TestXIncludeConfig, TestFreeTextSuggestions, TolerantUpdateProcessorTest, OverseerRolesTest, SuggesterWFSTTest, TestTolerantSearch, CdcrVersionReplicationTest, TestSubQueryTransformer, TestUtils, SpellPossibilityIteratorTest, TestLeaderElectionWithEmptyReplica, TestFieldTypeResource, TestSolrCloudWithSecureImpersonation, SubstringBytesRefFilterTest, TestComplexPhraseLeadingWildcard, TestCollationField, TestLegacyFieldCache, TestSolrFieldCacheMBean, JsonValidatorTest, TestSolrCoreSnapshots, OverseerTest, TestIndexingPerformance, DistribDocExpirationUpdateProcessorTest, TestReload, TestDelegationWithHadoopAuth, DocValuesMissingTest, TestOrdValues, TestFieldCacheSortRandom, CurrencyFieldXmlFileTest, TestDistributedStatsComponentCardinality, TestSolrQueryParser, TestSystemCollAutoCreate, LeaderElectionTest, BigEndianAscendingWordDeserializerTest, RollingRestartTest, TestReloadDeadlock, MigrateRouteKeyTest, UpdateLogTest, TestSchemalessBufferedUpdates, BlockJoinFacetDistribTest, PrimitiveFieldTypeTest, TestSSLRandomization, TestMergePolicyConfig, TestConfigReload, TestRecovery, HdfsUnloadDistributedZkTest, TestConfigSetProperties, CdcrReplicationDistributedZkTest, BooleanFieldTest, DistributedDebugComponentTest, SolrJmxReporterTest, SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ActionThrottleTest, CdcrReplicationHandlerTest, CleanupOldIndexTest, CollectionStateFormat2Test, CollectionsAPISolrJTest, CreateCollectionCleanupTest, DeleteLastCustomShardedReplicaTest, DeleteShardTest, DistribCursorPagingTest, HttpPartitionTest, MissingSegmentRecoveryTest, MultiThreadedOCPTest, TestClusterProperties, TestCryptoKeys, TestReplicaProperties, TestStressInPlaceUpdates, CoreSorterTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, TestBackupRepositoryFactory, TestConfigOverlay, TestConfigSetImmutable, TestImplicitCoreProperties, TestInitParams, TestReloadAndDeleteDocs, RequestLoggingTest, TestSQLHandler, DistributedFacetPivotSmallTest, InfixSuggestersTest, JavabinLoaderTest, HighlighterMaxOffsetTest, TestUnifiedSolrHighlighter, TestSlowCompositeReaderWrapper, SolrMetricManagerTest, SolrMetricReporterTest, SolrGangliaReporterTest, TestIntervalFaceting, TestJavabinTupleStreamParser, TestRawTransformer, TestSubQueryTransformerCrossCore, TestManagedResource, TestDefaultSearchFieldResource, TestDynamicFieldResource, TestFieldTypeCollectionResource, TestSchemaVersionResource, TestSolrQueryParserDefaultOperatorResource, TestUniqueKeyFieldResource, BadCopyFieldTest, ChangedSchemaMergeTest, DateRangeFieldTest, PreAnalyzedFieldManagedSchemaCloudTest, TestManagedSchemaAPI, TestManagedSchemaThreadSafety, TestUseDocValuesAsStored] [junit4] Completed [658/703 (1!)] on J2 in 44.66s, 6 tests, 1 error <<< FAILURES! [...truncated 39543 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org