Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/3244/ Java: 64bit/jdk1.8.0_121 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
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([371CEE0EE96C6B85:536E99011924F5C]: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 11130 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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/init-core-data-001 [junit4] 2> 97150 WARN (SUITE-TestUseDocValuesAsStored-seed#[371CEE0EE96C6B85]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=616 numCloses=616 [junit4] 2> 97150 INFO (SUITE-TestUseDocValuesAsStored-seed#[371CEE0EE96C6B85]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields [junit4] 2> 97152 INFO (SUITE-TestUseDocValuesAsStored-seed#[371CEE0EE96C6B85]-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> 97154 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testManagedSchema [junit4] 2> 97156 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 97165 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 97173 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] 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> 97175 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 97181 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 97182 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 97216 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] 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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 97219 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 97236 WARN (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97238 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97239 WARN (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97242 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97242 WARN (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97243 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97253 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 97262 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 97269 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 97269 INFO (coreLoadExecutor-330-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1, trusted=true [junit4] 2> 97269 WARN (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97270 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97271 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 97271 INFO (coreLoadExecutor-330-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/init-core-data-001/] [junit4] 2> 97280 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=57.8955078125, floorSegmentMB=1.1494140625, forceMergeDeletesPctAllowed=20.618819174935762, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.290955034231432 [junit4] 2> 97306 WARN (coreLoadExecutor-330-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> 97363 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 97363 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 97365 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 97365 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@60937184[collection1] main] [junit4] 2> 97366 INFO (coreLoadExecutor-330-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf [junit4] 2> 97366 INFO (coreLoadExecutor-330-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 97367 INFO (searcherExecutor-331-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@60937184[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 97368 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 97369 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 97382 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 97404 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 97405 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] 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> 97405 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 0 [junit4] 2> 97407 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97407 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@b429ffd [junit4] 2> 97459 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f13b06a[collection1] main] [junit4] 2> 97459 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 97459 INFO (searcherExecutor-331-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f13b06a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):c1)))} [junit4] 2> 97459 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 52 [junit4] 2> 97469 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=1 status=0 QTime=9 [junit4] 2> 97470 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 97470 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1809232011 [junit4] 2> 97470 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 97471 INFO (coreCloseExecutor-335-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4f1500ac [junit4] 2> 97472 INFO (coreCloseExecutor-335-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 97477 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 97479 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testManagedSchema [junit4] 2> 97480 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandomSingleAndMultiValued [junit4] 2> 97495 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 97515 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 97525 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97529 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 97541 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 97543 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1/conf/managed-schema [junit4] 2> 97564 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 97575 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 97631 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97634 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97635 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97640 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97640 WARN (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97641 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97653 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 97660 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 97667 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 97667 INFO (coreLoadExecutor-342-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1, trusted=true [junit4] 2> 97667 WARN (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer. [junit4] 2> 97667 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1aef1a8b [junit4] 2> 97667 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 97667 INFO (coreLoadExecutor-342-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/init-core-data-001/] [junit4] 2> 97671 WARN (coreLoadExecutor-342-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> 97703 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 97703 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 97704 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=57.8955078125, floorSegmentMB=1.1494140625, forceMergeDeletesPctAllowed=20.618819174935762, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.290955034231432 [junit4] 2> 97707 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@47c62d00[collection1] main] [junit4] 2> 97707 INFO (coreLoadExecutor-342-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001/tempDir-002/collection1/conf [junit4] 2> 97707 INFO (coreLoadExecutor-342-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 97708 INFO (searcherExecutor-343-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@47c62d00[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):c1)))} [junit4] 2> 97709 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 97709 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 97709 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97711 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1 [junit4] 2> 97724 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97724 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 97785 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7da634d7[collection1] main] [junit4] 2> 97786 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 97786 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7da634d7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1)))} [junit4] 2> 97786 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 62 [junit4] 2> 97788 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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=1 [junit4] 2> 97789 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97790 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97795 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97796 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97796 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97798 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1 [junit4] 2> 97798 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97798 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 97849 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@59835051[collection1] main] [junit4] 2> 97849 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 97849 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@59835051[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1)))} [junit4] 2> 97849 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 51 [junit4] 2> 97850 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97854 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97857 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97859 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97860 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_is_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97862 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 97864 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0 [junit4] 2> 97865 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97865 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 97928 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@19dfc529[collection1] main] [junit4] 2> 97929 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 97929 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@19dfc529[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1)))} [junit4] 2> 97929 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 64 [junit4] 2> 97930 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97930 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97931 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97931 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97932 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_d_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97932 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=3 status=0 QTime=0 [junit4] 2> 97934 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0 [junit4] 2> 97934 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97934 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 97971 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@796fc722[collection1] main] [junit4] 2> 97971 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 97971 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@796fc722[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1)))} [junit4] 2> 97972 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 37 [junit4] 2> 97972 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97974 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97976 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97977 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 97979 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_ls_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 97980 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 97983 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 1 [junit4] 2> 97984 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 97984 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98035 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a599dfb[collection1] main] [junit4] 2> 98036 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98036 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a599dfb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1) Uninverting(_5(6.6.0):c1)))} [junit4] 2> 98036 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 52 [junit4] 2> 98036 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98037 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98038 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98039 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98039 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98040 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=5 status=0 QTime=0 [junit4] 2> 98042 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 1 [junit4] 2> 98042 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98042 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98092 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4435440[collection1] main] [junit4] 2> 98093 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98093 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4435440[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1) Uninverting(_5(6.6.0):c1) Uninverting(_6(6.6.0):c1)))} [junit4] 2> 98093 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 50 [junit4] 2> 98093 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dt_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98095 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dt_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98095 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98096 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98097 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dt_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98097 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=6 status=0 QTime=0 [junit4] 2> 98099 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 1 [junit4] 2> 98099 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98099 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98145 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1523d507[collection1] main] [junit4] 2> 98146 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98146 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1523d507[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1) Uninverting(_5(6.6.0):c1) Uninverting(_6(6.6.0):c1) Uninverting(_7(6.6.0):c1)))} [junit4] 2> 98146 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 46 [junit4] 2> 98147 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98148 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98150 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98151 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98152 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98154 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=7 status=0 QTime=0 [junit4] 2> 98156 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0 [junit4] 2> 98157 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98157 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98229 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3ea31ec3[collection1] main] [junit4] 2> 98229 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98229 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3ea31ec3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1) 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> 98229 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 72 [junit4] 2> 98230 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98230 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98231 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=*vo2&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98232 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98232 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&fl=test_s_dvo2,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98232 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=8 status=0 QTime=0 [junit4] 2> 98234 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0 [junit4] 2> 98234 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98234 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98315 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@70df31aa[collection1] main] [junit4] 2> 98315 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98315 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@70df31aa[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.6.0):c1) Uninverting(_2(6.6.0):c1) Uninverting(_3(6.6.0):c1) Uninverting(_4(6.6.0):c1) 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> 98315 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 81 [junit4] 2> 98316 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&fl=enum_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98316 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&fl=enum_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98317 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98317 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98318 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&fl=enum_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98318 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=9 status=0 QTime=0 [junit4] 2> 98319 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 98320 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98321 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[10]} 0 0 [junit4] 2> 98321 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98321 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98365 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a488cd8[collection1] main] [junit4] 2> 98365 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98365 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a488cd8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1)))} [junit4] 2> 98366 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 45 [junit4] 2> 98367 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&fl=test_s_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98367 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&fl=test_s_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98368 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98368 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98369 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:10&fl=test_s_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98369 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98371 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11]} 0 1 [junit4] 2> 98371 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98371 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98440 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@65b5b6ca[collection1] main] [junit4] 2> 98441 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98441 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@65b5b6ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1)))} [junit4] 2> 98441 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 69 [junit4] 2> 98441 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:11&fl=test_i_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98442 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:11&fl=test_i_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98443 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:11&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98443 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:11&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98443 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:11&fl=test_i_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98444 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 98444 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[12]} 0 0 [junit4] 2> 98445 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98445 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98526 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@36998c56[collection1] main] [junit4] 2> 98527 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98527 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@36998c56[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1)))} [junit4] 2> 98527 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 82 [junit4] 2> 98527 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&fl=test_d_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98528 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&fl=test_d_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98528 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98528 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98529 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&fl=test_d_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98529 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=3 status=0 QTime=0 [junit4] 2> 98531 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[13]} 0 1 [junit4] 2> 98531 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98531 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98621 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@473f8f51[collection1] main] [junit4] 2> 98621 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98621 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@473f8f51[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1)))} [junit4] 2> 98621 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 90 [junit4] 2> 98622 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&fl=test_l_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98623 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&fl=test_l_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98623 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98624 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98624 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:13&fl=test_l_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98624 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 98625 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[14]} 0 0 [junit4] 2> 98626 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98626 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98664 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@491dec39[collection1] main] [junit4] 2> 98664 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98664 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@491dec39[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1) Uninverting(_e(6.6.0):c1)))} [junit4] 2> 98664 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 38 [junit4] 2> 98665 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&fl=test_fs_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98666 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&fl=test_fs_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98667 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98673 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98674 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&fl=test_fs_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98675 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=5 status=0 QTime=0 [junit4] 2> 98676 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[15]} 0 0 [junit4] 2> 98676 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98676 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98727 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7a04a3df[collection1] main] [junit4] 2> 98727 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98727 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7a04a3df[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1) Uninverting(_e(6.6.0):c1) Uninverting(_f(6.6.0):c1)))} [junit4] 2> 98727 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 50 [junit4] 2> 98728 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&fl=test_dt_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98728 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&fl=test_dt_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98729 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98729 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98729 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&fl=test_dt_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98730 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=6 status=0 QTime=0 [junit4] 2> 98731 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[16]} 0 0 [junit4] 2> 98731 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98731 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98773 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@200d6f45[collection1] main] [junit4] 2> 98774 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98774 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@200d6f45[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1) Uninverting(_e(6.6.0):c1) Uninverting(_f(6.6.0):c1) Uninverting(_g(6.6.0):c1)))} [junit4] 2> 98774 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 42 [junit4] 2> 98775 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&fl=test_s_dv&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98775 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&fl=test_s_dv,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98775 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&fl=*_dv&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98776 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98776 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&fl=test_s_dv,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98777 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=7 status=0 QTime=0 [junit4] 2> 98778 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[17]} 0 1 [junit4] 2> 98779 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98779 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98836 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fdaeedb[collection1] main] [junit4] 2> 98836 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98836 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3fdaeedb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1) Uninverting(_e(6.6.0):c1) Uninverting(_f(6.6.0):c1) Uninverting(_g(6.6.0):c1) Uninverting(_h(6.6.0):c1)))} [junit4] 2> 98836 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 57 [junit4] 2> 98837 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:17&fl=test_s_dvo2&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98837 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:17&fl=test_s_dvo2,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98838 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:17&fl=*vo2&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98838 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:17&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98839 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:17&fl=test_s_dvo2,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98839 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=8 status=0 QTime=0 [junit4] 2> 98841 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[18]} 0 0 [junit4] 2> 98841 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98841 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98902 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4aa32d46[collection1] main] [junit4] 2> 98903 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98903 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4aa32d46[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_a(6.6.0):c1) Uninverting(_b(6.6.0):c1) Uninverting(_c(6.6.0):c1) Uninverting(_d(6.6.0):c1) Uninverting(_e(6.6.0):c1) Uninverting(_f(6.6.0):c1) Uninverting(_g(6.6.0):c1) Uninverting(_h(6.6.0):c1) Uninverting(_i(6.6.0):c1)))} [junit4] 2> 98903 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 62 [junit4] 2> 98904 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&fl=enums_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98904 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&fl=enums_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98905 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98906 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98906 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:18&fl=enums_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98907 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=9 status=0 QTime=0 [junit4] 2> 98908 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 98908 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] 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> 98908 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[19]} 0 0 [junit4] 2> 98909 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98909 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 98968 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7077f6e0[collection1] main] [junit4] 2> 98968 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 98968 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7077f6e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_j(6.6.0):c1)))} [junit4] 2> 98969 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 60 [junit4] 2> 98970 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&fl=test_s_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98971 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&fl=test_s_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98971 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98972 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98972 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&fl=test_s_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98972 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 98973 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[20]} 0 0 [junit4] 2> 98973 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 98973 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 99047 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b2f42e5[collection1] main] [junit4] 2> 99047 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 99047 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7b2f42e5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_j(6.6.0):c1) Uninverting(_k(6.6.0):c1)))} [junit4] 2> 99047 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 73 [junit4] 2> 99048 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:20&fl=test_is_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99048 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:20&fl=test_is_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99049 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:20&fl=*dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99049 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:20&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99050 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:20&fl=test_is_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99050 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 99051 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[21]} 0 0 [junit4] 2> 99052 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 99052 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ee43686 [junit4] 2> 99093 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@58b50470[collection1] main] [junit4] 2> 99094 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 99094 INFO (searcherExecutor-343-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58b50470[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_j(6.6.0):c1) Uninverting(_k(6.6.0):c1) Uninverting(_l(6.6.0):c1)))} [junit4] 2> 99094 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 42 [junit4] 2> 99094 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:21&fl=test_ds_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99096 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:21&fl=test_ds_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 99097 INFO (TEST-TestUseDocValuesAsStored.te [...truncated too long message...] ed.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 118717 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118717 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 118717 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2935bdae [junit4] 2> 118755 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@765cf4ff[collection1] main] [junit4] 2> 118755 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 118755 INFO (searcherExecutor-391-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@765cf4ff[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 118756 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 39 [junit4] 2> 118756 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 118756 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 118757 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118757 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118758 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 118759 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2935bdae [junit4] 2> 118814 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@49b10e13[collection1] main] [junit4] 2> 118815 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 118815 INFO (searcherExecutor-391-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@49b10e13[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7m(6.6.0):c1)))} [junit4] 2> 118815 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 55 [junit4] 2> 118815 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 118816 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 118816 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118816 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] 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> 118816 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 118817 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 118817 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2935bdae [junit4] 2> 118883 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7bcc0b75[collection1] main] [junit4] 2> 118883 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 118883 INFO (searcherExecutor-391-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7bcc0b75[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7n(6.6.0):c1)))} [junit4] 2> 118884 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 67 [junit4] 2> 118884 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 118884 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 118884 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1667283265 [junit4] 2> 118884 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 118885 INFO (coreCloseExecutor-395-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3a522479 [junit4] 2> 118886 INFO (coreCloseExecutor-395-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 118889 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 118892 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[371CEE0EE96C6B85]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOnEmptyIndex [junit4] 2> 118895 INFO (SUITE-TestUseDocValuesAsStored-seed#[371CEE0EE96C6B85]-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/J0/temp/solr.schema.TestUseDocValuesAsStored_371CEE0EE96C6B85-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=554, maxMBSortInHeap=5.7160813783678694, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=lv-LV, timezone=America/Merida [junit4] 2> NOTE: Linux 4.4.0-72-generic amd64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=12,threads=1,free=394964904,total=508887040 [junit4] 2> NOTE: All tests run in this JVM: [TestExpandComponent, TestRandomFaceting, FullHLLTest, SynonymTokenizerTest, BigEndianAscendingWordSerializerTest, TestComponentsName, RequestLoggingTest, SolrCoreTest, PolyFieldTest, FastVectorHighlighterTest, TestIBSimilarityFactory, TestSolrQueryParserResource, TestFunctionQuery, CloudMLTQParserTest, ResourceLoaderTest, SolrMetricManagerTest, TestTolerantUpdateProcessorCloud, TestUseDocValuesAsStored] [junit4] Completed [43/703 (1!)] on J0 in 21.76s, 6 tests, 1 error <<< FAILURES! [...truncated 45514 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org