Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-MacOSX/827/ Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
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([E7F98B92BAB3A8DE:D5D38C0C424D8C07]:0) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:983) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:930) 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 13027 lines...] [junit4] Suite: org.apache.solr.schema.TestUseDocValuesAsStored [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001 [junit4] 2> 4782017 WARN (SUITE-TestUseDocValuesAsStored-seed#[E7F98B92BAB3A8DE]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1929 numCloses=1929 [junit4] 2> 4782019 INFO (SUITE-TestUseDocValuesAsStored-seed#[E7F98B92BAB3A8DE]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields [junit4] 2> 4782027 INFO (SUITE-TestUseDocValuesAsStored-seed#[E7F98B92BAB3A8DE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth [junit4] 2> 4782029 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testUseDocValuesAsStoredFalse [junit4] 2> 4782045 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 4782076 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4782099 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4782104 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 4782118 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4782120 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 4782125 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 4782134 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 4782741 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4782750 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4782751 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4782789 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4782797 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 4782812 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4782812 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1, trusted=true [junit4] 2> 4782813 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4782814 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 4782814 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001/] [junit4] 2> 4782819 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11235207973829767] [junit4] 2> 4782838 WARN (coreLoadExecutor-9838-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> 4782999 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4782999 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4783001 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=27, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=4.705078125, floorSegmentMB=1.4716796875, forceMergeDeletesPctAllowed=3.5399957055908313, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5890758213813347 [junit4] 2> 4783014 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@78d89c6b[collection1] main] [junit4] 2> 4783015 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-001/collection1/conf [junit4] 2> 4783016 INFO (coreLoadExecutor-9838-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4783016 INFO (searcherExecutor-9839-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@78d89c6b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 4783018 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 4783020 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid]} 0 1 [junit4] 2> 4783029 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4783029 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6a1ed0b2 [junit4] 2> 4783060 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@28dc6871[collection1] main] [junit4] 2> 4783061 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4783061 INFO (searcherExecutor-9839-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@28dc6871[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C1)))} [junit4] 2> 4783061 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 32 [junit4] 2> 4783062 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4783062 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4783063 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=id,nonstored_dv_*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4783063 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid&fl=id,nonstored_dv_str&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4783064 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4783064 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4783064 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 4783064 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=174330225 [junit4] 2> 4783065 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 4783065 INFO (coreCloseExecutor-9843-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5a74a846 [junit4] 2> 4783081 INFO (coreCloseExecutor-9843-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 4783087 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 4783088 INFO (TEST-TestUseDocValuesAsStored.testUseDocValuesAsStoredFalse-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testUseDocValuesAsStoredFalse [junit4] 2> 4783090 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMultipleSearchResults [junit4] 2> 4783097 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 4783165 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4783178 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4783182 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 4783204 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4783205 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1/conf/managed-schema [junit4] 2> 4783220 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 4783224 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 4783320 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783328 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783329 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783354 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4783368 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 4783383 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4783384 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1, trusted=true [junit4] 2> 4783384 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783384 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 4783384 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001/] [junit4] 2> 4783392 WARN (coreLoadExecutor-9850-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> 4783522 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4783522 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4783524 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11235207973829767] [junit4] 2> 4783609 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@409984ac[collection1] main] [junit4] 2> 4783610 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-002/collection1/conf [junit4] 2> 4783610 INFO (coreLoadExecutor-9850-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4783610 INFO (searcherExecutor-9851-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@409984ac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C1)))} [junit4] 2> 4783611 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 4783613 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 1 [junit4] 2> 4783613 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid2]} 0 0 [junit4] 2> 4783629 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid3]} 0 0 [junit4] 2> 4783629 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid4]} 0 0 [junit4] 2> 4783630 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid5]} 0 0 [junit4] 2> 4783630 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid6]} 0 0 [junit4] 2> 4783630 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4783630 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6ee47259 [junit4] 2> 4783716 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a95f1c5[collection1] main] [junit4] 2> 4783716 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4783716 INFO (searcherExecutor-9851-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a95f1c5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C1) Uninverting(_1(6.6.0):C6)))} [junit4] 2> 4783717 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 86 [junit4] 2> 4783719 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=7 status=0 QTime=1 [junit4] 2> 4783720 ERROR (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=mismatch: 'myid1'!='myid' @ response/docs/[0]/id [junit4] 2> expected =/response/docs==[{'id':'myid1','test_is_dvo':[101,102,103]},{'id':'myid2','test_is_dvo':[201,202]},{'id':'myid3','test_is_dvo':[301,302,303,304]},{'id':'myid4','test_s_dvo':'hello','test_is_dvo':[401,402]},{'id':'myid5'},{'id':'myid6','test_s_dvo':'hello'}] [junit4] 2> response = { [junit4] 2> "responseHeader":{ [junit4] 2> "status":0, [junit4] 2> "QTime":1}, [junit4] 2> "response":{"numFound":7,"start":0,"docs":[ [junit4] 2> { [junit4] 2> "id":"myid"}, [junit4] 2> { [junit4] 2> "id":"myid1", [junit4] 2> "test_is_dvo":[101, [junit4] 2> 102, [junit4] 2> 103]}, [junit4] 2> { [junit4] 2> "id":"myid2", [junit4] 2> "test_is_dvo":[201, [junit4] 2> 202]}, [junit4] 2> { [junit4] 2> "id":"myid3", [junit4] 2> "test_is_dvo":[301, [junit4] 2> 302, [junit4] 2> 303, [junit4] 2> 304]}, [junit4] 2> { [junit4] 2> "id":"myid4", [junit4] 2> "test_s_dvo":"hello", [junit4] 2> "test_is_dvo":[401, [junit4] 2> 402]}, [junit4] 2> { [junit4] 2> "id":"myid5"}, [junit4] 2> { [junit4] 2> "id":"myid6", [junit4] 2> "test_s_dvo":"hello"}] [junit4] 2> }} [junit4] 2> [junit4] 2> request = q=id:myid*&fl=*&wt=xml [junit4] 2> 4783721 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4783721 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4783721 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 4783721 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1276675770 [junit4] 2> 4783722 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 4783722 INFO (coreCloseExecutor-9855-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6ad0dafd [junit4] 2> 4783745 INFO (coreCloseExecutor-9855-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 4783749 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 4783751 INFO (TEST-TestUseDocValuesAsStored.testMultipleSearchResults-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultipleSearchResults [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestUseDocValuesAsStored -Dtests.method=testMultipleSearchResults -Dtests.seed=E7F98B92BAB3A8DE -Dtests.slow=true -Dtests.locale=uk-UA -Dtests.timezone=Pacific/Nauru -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.67s J0 | TestUseDocValuesAsStored.testMultipleSearchResults <<< [junit4] > Throwable #1: java.lang.RuntimeException: mismatch: 'myid1'!='myid' @ response/docs/[0]/id [junit4] > at __randomizedtesting.SeedInfo.seed([E7F98B92BAB3A8DE:D5D38C0C424D8C07]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:983) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:930) [junit4] > at org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults(TestUseDocValuesAsStored.java:243) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 4783760 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testManagedSchema [junit4] 2> 4783769 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 4783801 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4783814 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4783818 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 4783846 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4783854 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf/managed-schema [junit4] 2> 4783873 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 4783877 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 4783945 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783949 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783949 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783976 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4783984 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 4783995 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4783995 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1, trusted=true [junit4] 2> 4783995 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4783995 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 4783995 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001/] [junit4] 2> 4784000 WARN (coreLoadExecutor-9862-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> 4784086 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4784086 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4784089 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11235207973829767] [junit4] 2> 4784197 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f10cf91[collection1] main] [junit4] 2> 4784204 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf [junit4] 2> 4784210 INFO (coreLoadExecutor-9862-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4784217 INFO (searcherExecutor-9863-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f10cf91[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.6.0):C1) Uninverting(_1(6.6.0):C6)))} [junit4] 2> 4784237 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 4784238 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf/managed-schema [junit4] 2> 4784242 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-003/collection1/conf/managed-schema [junit4] 2> 4784257 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4784259 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] 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 2 [junit4] 2> 4784260 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[myid1]} 0 1 [junit4] 2> 4784260 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4784261 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@304c7cad [junit4] 2> 4784296 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6154e5ff[collection1] main] [junit4] 2> 4784296 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4784296 INFO (searcherExecutor-9863-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6154e5ff[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.6.0):C1)))} [junit4] 2> 4784300 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 40 [junit4] 2> 4784301 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:myid*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4784302 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4784302 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784302 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 4784302 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=707714882 [junit4] 2> 4784303 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 4784303 INFO (coreCloseExecutor-9867-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6baf17cf [junit4] 2> 4784362 INFO (coreCloseExecutor-9867-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 4784366 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 4784368 INFO (TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testManagedSchema [junit4] 2> 4784370 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOnEmptyIndex [junit4] 2> 4784377 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 4784403 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4784414 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784417 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 4784428 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4784428 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1/conf/managed-schema [junit4] 2> 4784441 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1/conf/schema-non-stored-docvalues.xml to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 4784445 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 4784518 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784523 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784523 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784545 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4784553 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 4784586 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4784586 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1, trusted=true [junit4] 2> 4784586 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784586 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 4784586 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001/] [junit4] 2> 4784591 WARN (coreLoadExecutor-9874-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> 4784670 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4784670 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4784672 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11235207973829767] [junit4] 2> 4784680 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5986b5ce[collection1] main] [junit4] 2> 4784681 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-004/collection1/conf [junit4] 2> 4784682 INFO (coreLoadExecutor-9874-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4784682 INFO (searcherExecutor-9875-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5986b5ce[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.6.0):C1)))} [junit4] 2> 4784684 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 4784684 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4784685 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 1 [junit4] 2> 4784685 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4784685 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@77aa5e5d [junit4] 2> 4784696 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@199abb32[collection1] main] [junit4] 2> 4784697 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4784697 INFO (searcherExecutor-9875-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@199abb32[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 4784700 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 14 [junit4] 2> 4784700 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 4784700 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 4784701 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784701 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784702 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 4784702 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 4784702 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 4784702 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784703 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784703 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4784703 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@77aa5e5d [junit4] 2> 4784762 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5af85c48[collection1] main] [junit4] 2> 4784762 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4784763 INFO (searcherExecutor-9875-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5af85c48[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.6.0):C1)))} [junit4] 2> 4784763 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 60 [junit4] 2> 4784763 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4784764 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4784764 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784764 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784765 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[xyz]} 0 0 [junit4] 2> 4784765 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4784765 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@77aa5e5d [junit4] 2> 4784820 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5927185a[collection1] main] [junit4] 2> 4784821 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4784821 INFO (searcherExecutor-9875-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5927185a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.6.0):C1)))} [junit4] 2> 4784826 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 61 [junit4] 2> 4784827 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4784828 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4784828 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784828 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 4784828 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=440827166 [junit4] 2> 4784829 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 4784829 INFO (coreCloseExecutor-9879-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1ac5e22f [junit4] 2> 4784831 INFO (coreCloseExecutor-9879-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 4784835 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 4784836 INFO (TEST-TestUseDocValuesAsStored.testOnEmptyIndex-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOnEmptyIndex [junit4] 2> 4784838 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandomSingleAndMultiValued [junit4] 2> 4784848 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 4784886 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4784896 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4784898 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema [null] Schema name=test-non-stored-docvalues [junit4] 2> 4784909 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4784910 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1/conf/managed-schema [junit4] 2> 4784920 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1/conf/schema-non-stored-docvalues.xml to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1/conf/schema-non-stored-docvalues.xml.bak [junit4] 2> 4784926 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 4784994 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784998 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4784998 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4785025 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0 [junit4] 2> 4785036 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test-non-stored-docvalues [junit4] 2> 4785047 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test-non-stored-docvalues/1.6 with uniqueid field id [junit4] 2> 4785047 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1, trusted=true [junit4] 2> 4785047 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@69d780bf [junit4] 2> 4785048 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 4785048 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/init-core-data-001/] [junit4] 2> 4785052 WARN (coreLoadExecutor-9886-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> 4785161 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4785161 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4785163 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11235207973829767] [junit4] 2> 4785168 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@461f6bd8[collection1] main] [junit4] 2> 4785169 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001/tempDir-005/collection1/conf [junit4] 2> 4785170 INFO (coreLoadExecutor-9886-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4785170 INFO (searcherExecutor-9887-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@461f6bd8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.6.0):C1)))} [junit4] 2> 4785172 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 4785172 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4785173 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*} 0 1 [junit4] 2> 4785176 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 1 [junit4] 2> 4785176 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785176 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785210 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@66f36cfc[collection1] main] [junit4] 2> 4785211 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785211 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@66f36cfc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1)))} [junit4] 2> 4785213 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 37 [junit4] 2> 4785214 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_ss_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785220 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_ss_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785234 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785258 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785261 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=test_ss_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785262 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785266 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 1 [junit4] 2> 4785269 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785269 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785343 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b5aee3d[collection1] main] [junit4] 2> 4785344 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b5aee3d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1)))} [junit4] 2> 4785344 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785345 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 75 [junit4] 2> 4785347 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 4785348 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785348 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785349 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785349 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&fl=test_i_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785350 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=2 status=0 QTime=0 [junit4] 2> 4785354 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 1 [junit4] 2> 4785356 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785356 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785388 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4e0ea72c[collection1] main] [junit4] 2> 4785388 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785388 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4e0ea72c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1)))} [junit4] 2> 4785388 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 32 [junit4] 2> 4785389 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785390 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785391 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785391 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785392 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:3&fl=test_ds_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785393 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=3 status=0 QTime=0 [junit4] 2> 4785399 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 4 [junit4] 2> 4785399 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785399 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785461 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@745ea211[collection1] main] [junit4] 2> 4785462 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@745ea211[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1)))} [junit4] 2> 4785463 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785463 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 63 [junit4] 2> 4785464 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785464 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785465 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785466 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785467 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:4&fl=test_l_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785468 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=4 status=0 QTime=0 [junit4] 2> 4785470 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 1 [junit4] 2> 4785470 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785470 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785582 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a0dfd03[collection1] main] [junit4] 2> 4785584 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a0dfd03[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1)))} [junit4] 2> 4785585 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785585 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 114 [junit4] 2> 4785591 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo&wt=xml} hits=1 status=0 QTime=5 [junit4] 2> 4785600 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo,*&wt=xml} hits=1 status=0 QTime=2 [junit4] 2> 4785601 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785601 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785602 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&fl=test_f_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785603 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=5 status=0 QTime=0 [junit4] 2> 4785606 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 1 [junit4] 2> 4785607 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785607 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785660 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@26b54e9a[collection1] main] [junit4] 2> 4785661 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785661 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@26b54e9a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1) Uninverting(_a(6.6.0):C1)))} [junit4] 2> 4785661 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 54 [junit4] 2> 4785662 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785664 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785665 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785668 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785669 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:6&fl=test_dts_dvo,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785670 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=6 status=0 QTime=0 [junit4] 2> 4785673 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 1 [junit4] 2> 4785674 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785674 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785713 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4d887c1e[collection1] main] [junit4] 2> 4785714 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785714 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4d887c1e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uninverting(_9(6.6.0):C1) Uninverting(_a(6.6.0):C1) Uninverting(_b(6.6.0):C1)))} [junit4] 2> 4785714 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 40 [junit4] 2> 4785715 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785716 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv,*&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785716 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785717 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4785718 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:7&fl=test_s_dv,fakeFieldName&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 4785718 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&fl=*&wt=xml} hits=7 status=0 QTime=0 [junit4] 2> 4785720 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 1 [junit4] 2> 4785721 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 4785721 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@44d43044 [junit4] 2> 4785772 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@99d6a46[collection1] main] [junit4] 2> 4785772 INFO (TEST-TestUseDocValuesAsStored.testRandomSingleAndMultiValued-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 4785773 INFO (searcherExecutor-9887-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@99d6a46[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.6.0):C1) Uninverting(_6(6.6.0):C1) Uninverting(_7(6.6.0):C1) Uninverting(_8(6.6.0):C1) Uni [...truncated too long message...] t4] 2> 4791890 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 4791890 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] 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> 4791890 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 4791890 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1217991663 [junit4] 2> 4791891 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 4791891 INFO (coreCloseExecutor-9903-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@116f33f3 [junit4] 2> 4791893 INFO (coreCloseExecutor-9903-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 4791916 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 4791918 INFO (TEST-TestUseDocValuesAsStored.testMultivaluedOrdering-seed#[E7F98B92BAB3A8DE]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMultivaluedOrdering [junit4] 2> 4791932 INFO (SUITE-TestUseDocValuesAsStored-seed#[E7F98B92BAB3A8DE]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_E7F98B92BAB3A8DE-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=371, maxMBSortInHeap=7.9548696279166276, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=uk-UA, timezone=Pacific/Nauru [junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=3,threads=1,free=174948768,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestConfigSetsAPIZkFailure, TestDownShardTolerantSearch, DistributedSpellCheckComponentTest, UniqFieldsUpdateProcessorFactoryTest, SegmentsInfoRequestHandlerTest, TestExportWriter, PrimitiveFieldTypeTest, TestBulkSchemaConcurrent, MigrateRouteKeyTest, SmileWriterTest, TestBinaryResponseWriter, XsltUpdateRequestHandlerTest, TestTolerantSearch, TestReRankQParserPlugin, SoftAutoCommitTest, ResponseLogComponentTest, PeerSyncReplicationTest, TestLFUCache, InfixSuggestersTest, TestConfigOverlay, BaseCdcrDistributedZkTest, InfoHandlerTest, ExplicitHLLTest, FileUtilsTest, OverriddenZkACLAndCredentialsProvidersTest, PreAnalyzedFieldManagedSchemaCloudTest, TestScoreJoinQPNoScore, TermsComponentTest, TestUpdate, TestPostingsSolrHighlighter, TestSolrDynamicMBean, AnalysisAfterCoreReloadTest, TestAuthenticationFramework, WrapperMergePolicyFactoryTest, TestFunctionQuery, CurrencyFieldXmlFileTest, BlockJoinFacetSimpleTest, TestSort, TestSolrCloudWithDelegationTokens, TestElisionMultitermQuery, SolrMetricReporterTest, SimplePostToolTest, TimeZoneUtilsTest, TestSolrFieldCacheMBean, TestReplicationHandlerBackup, TemplateUpdateProcessorTest, TestPseudoReturnFields, TestConfigSetProperties, SchemaVersionSpecificBehaviorTest, RequestLoggingTest, OverseerModifyCollectionTest, TestRestManager, TestPhraseSuggestions, SystemInfoHandlerTest, TestStressVersions, TestMiniSolrCloudCluster, TestLRUCache, TestSubQueryTransformerCrossCore, TestCollationField, DirectSolrConnectionTest, TestWordDelimiterFilterFactory, ChaosMonkeyNothingIsSafeTest, BigEndianAscendingWordSerializerTest, TestEmbeddedSolrServerConstructors, PKIAuthenticationIntegrationTest, DeleteReplicaTest, TestSolrQueryParserDefaultOperatorResource, ExitableDirectoryReaderTest, SampleTest, TestRandomFlRTGCloud, TestUnifiedSolrHighlighter, DistributedQueryElevationComponentTest, LeaderFailoverAfterPartitionTest, TestLegacyFieldCache, TestStressUserVersions, RecoveryZkTest, CloneFieldUpdateProcessorFactoryTest, TestConfigReload, QueryElevationComponentTest, TestApiFramework, AssignTest, TestManagedSchemaAPI, DistributedQueueTest, DirectUpdateHandlerTest, RemoteQueryErrorTest, DirectSolrSpellCheckerTest, CdcrReplicationDistributedZkTest, TestHdfsUpdateLog, IndexBasedSpellCheckerTest, TestStressInPlaceUpdates, TestSchemalessBufferedUpdates, TestCloudInspectUtil, CdcrRequestHandlerTest, TestExtendedDismaxParser, NumericFieldsTest, TestSchemaVersionResource, TestShortCircuitedRequests, TestPartialUpdateDeduplication, TestRawTransformer, CollectionStateFormat2Test, ConjunctionSolrSpellCheckerTest, V2ApiIntegrationTest, TestOverriddenPrefixQueryForCustomFieldType, StatelessScriptUpdateProcessorFactoryTest, EnumFieldTest, TestAnalyzeInfixSuggestions, TestSolrCloudSnapshots, HdfsDirectoryTest, TestLocalFSCloudBackupRestore, JSONWriterTest, DocValuesTest, XmlUpdateRequestHandlerTest, TestFieldCacheSort, TestCorePropertiesReload, TestJsonRequest, TestObjectReleaseTracker, TestUseDocValuesAsStored2, RollingRestartTest, TestSolrCLIRunExample, TestMaxScoreQueryParser, TestMinMaxOnMultiValuedField, TestRandomDVFaceting, CdcrUpdateLogTest, TestNRTOpen, PrimUtilsTest, DisMaxRequestHandlerTest, BlockJoinFacetDistribTest, TestLeaderElectionZkExpiry, HdfsChaosMonkeySafeLeaderTest, JSONWriterTest, AnalyticsQueryTest, OverseerStatusTest, TestHdfsCloudBackupRestore, DocumentAnalysisRequestHandlerTest, HardAutoCommitTest, TestFileDictionaryLookup, IgnoreCommitOptimizeUpdateProcessorFactoryTest, SolrGangliaReporterTest, SyncSliceTest, BadComponentTest, PeerSyncWithIndexFingerprintCachingTest, TestFieldCacheVsDocValues, TestManagedSynonymFilterFactory, HdfsRecoveryZkTest, ZkNodePropsTest, LeaderElectionTest, CollectionsAPIAsyncDistributedZkTest, HdfsBasicDistributedZkTest, TestCursorMarkWithoutUniqueKey, ActionThrottleTest, PluginInfoTest, TestNumericTerms64, TestPivotHelperCode, ConcurrentDeleteAndCreateCollectionTest, TestHighlightDedupGrouping, SolrCoreTest, TestSolrConfigHandlerConcurrent, DeleteLastCustomShardedReplicaTest, SolrPluginUtilsTest, TestSolr4Spatial2, PropertiesRequestHandlerTest, TestCustomSort, TestPKIAuthenticationPlugin, JavabinLoaderTest, TestConfigSetsAPI, ShufflingReplicaListTransformerTest, TestManagedResource, PreAnalyzedUpdateProcessorTest, ZkCLITest, BooleanFieldTest, ZkStateWriterTest, RankQueryTest, BasicDistributedZkTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, LeaderElectionIntegrationTest, ShardRoutingTest, BasicZkTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, ShardRoutingCustomTest, TestDistributedSearch, PeerSyncTest, TestBadConfig, HighlighterTest, CurrencyFieldOpenExchangeTest, SuggesterFSTTest, TestFoldingMultitermQuery, SuggesterTest, SpatialFilterTest, PolyFieldTest, SolrCoreCheckLockOnStartupTest, QueryEqualityTest, DefaultValueUpdateProcessorTest, TestRemoteStreaming, TestSolrDeletionPolicy1, CacheHeaderTest, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, TestQueryTypes, FileBasedSpellCheckerTest, PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, TestSolrQueryParser, LoggingHandlerTest, TestJmxIntegration, QueryParsingTest, TestAnalyzedSuggestions, CSVRequestHandlerTest, TestComponentsName, SOLR749Test, UpdateParamsTest, AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, SolrIndexConfigTest, TestStressRecovery, CloudExitableDirectoryReaderTest, CollectionsAPISolrJTest, DeleteInactiveReplicaTest, DistribCursorPagingTest, DistribJoinFromCollectionTest, DocValuesNotIndexedTest, ForceLeaderTest, LeaderFailureAfterFreshStartTest, LeaderInitiatedRecoveryOnShardRestartTest, MoveReplicaTest, ReplaceNodeTest, SharedFSAutoReplicaFailoverTest, SimpleCollectionCreateDeleteTest, SolrCloudExampleTest, TestCloudPseudoReturnFields, TestCloudRecovery, TestDistribDocBasedVersion, TestMiniSolrCloudClusterSSL, TestRequestForwarding, TestSSLRandomization, TestSizeLimitedDistributedMap, TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorRandomCloud, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, RuleEngineTest, RulesTest, BlobRepositoryCloudTest, TestConfigSets, TestDynamicLoading, TestSQLHandlerNonCloud, TestSolrConfigHandlerCloud, DistributedFacetPivotLongTailTest, DistributedSuggestComponentTest, HighlighterMaxOffsetTest, JvmMetricsTest, SolrCoreMetricManagerTest, SolrMetricsIntegrationTest, SolrGraphiteReporterTest, SolrJmxReporterTest, TestIntervalFaceting, TestMacroExpander, TestBinaryResponseWriter, TestCustomDocTransformer, TestGeoJSONResponseWriter, TestGraphMLResponseWriter, TestPushWriter, TestRawResponseWriter, TestSolrQueryResponse, TestChildDocTransformer, TestSubQueryTransformer, TestSubQueryTransformerDistrib, TestManagedResourceStorage, TestClassNameShortening, TestDefaultSearchFieldResource, TestDynamicFieldResource, TestFieldResource, TestFieldTypeResource, TestSchemaNameResource, TestSchemaResource, TestSchemaSimilarityResource, TestSerializedLuceneMatchVersion, TestUniqueKeyFieldResource, BadCopyFieldTest, ChangedSchemaMergeTest, SpatialRPTFieldTypeTest, TestCollationFieldDocValues, TestPointFields, TestUseDocValuesAsStored] [junit4] Completed [632/704 (1!)] on J0 in 10.01s, 6 tests, 1 error <<< FAILURES! [...truncated 43610 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org