[
https://issues.apache.org/jira/browse/SOLR-7611?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Hoss Man updated SOLR-7611:
---------------------------
Attachment: SOLR-7611_test.patch
This test does a bunch of "commits" that are suppose to be No-Ops and then
confirms the the searcher hasn't changed.
if you read the logs, you can see that just before the failures, there are in
fact new segment files, so there are new readers, so the searchers must change
-- but the attached patch makes this more clear by adding some additional
asserts on the underlying readers before comparing the searchers themselves.
(the toString of the searcher that gets printed in the existing assert shows
it's Object.hashCode() to make it clear they are diff, and the reader
toString()s are included, but the reader.toString()s can look identicale even
though they are not -- hence the new asserts)
it's not yet clear to me why the new segment files are getting written
_sometimes_ .. best guess is that maybe this is somehow related to LUCENE-6505?
> TestSearcherReuse failure
> -------------------------
>
> Key: SOLR-7611
> URL: https://issues.apache.org/jira/browse/SOLR-7611
> Project: Solr
> Issue Type: Bug
> Affects Versions: 5.2
> Reporter: Steve Rowe
> Attachments: SOLR-7611_test.patch
>
>
> {noformat}
> [junit4] FAILURE 0.94s | TestSearcherReuse.test <<<
> [junit4] > Throwable #1: java.lang.AssertionError: expected
> same:<Searcher@66681f2[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}> was not:<Searcher@5d94043f[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}>
> [junit4] > at
> __randomizedtesting.SeedInfo.seed([F1A11DF972B907D6:79F52223DC456A2E]:0)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:104)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> {noformat}
> Reproduces for me on the 5.2 release branch with the following - note that
> both {{-Dtests.multiplier=2}} and {{-Dtests.nightly=true}} are required to
> reproduce:
> {noformat}
> ant test -Dtestcase=TestSearcherReuse -Dtests.seed=F1A11DF972B907D6
> -Dtests.multiplier=2 -Dtests.nightly=true
> {noformat}
> Full log:
> {noformat}
> [junit4] <JUnit4> says hallo! Master seed: F1A11DF972B907D6
> [junit4] Executing 1 suite with 1 JVM.
> [junit4]
> [junit4] Started J0 PID([email protected]).
> [junit4] Suite: org.apache.solr.search.TestSearcherReuse
> [junit4] 2> log4j:WARN No such property [conversionPattern] in
> org.apache.solr.util.SolrLogLayout.
> [junit4] 2> Creating dataDir:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001
> [junit4] 2> 889 T11 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
> (false) and clientAuth (false)
> [junit4] 2> 959 T11 oas.SolrTestCaseJ4.initCore ####initCore
> [junit4] 2> 1093 T11 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory:
> '/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/'
> [junit4] 2> 1390 T11 oasc.SolrConfig.refreshRequestParams current
> version of requestparams : -1
> [junit4] 2> 1449 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion:
> 5.2.0
> [junit4] 2> 1551 T11 oasc.SolrConfig.<init> Loaded SolrConfig:
> solrconfig-managed-schema.xml
> [junit4] 2> 1563 T11 oass.ManagedIndexSchemaFactory.readSchemaLocally
> The schema is configured as managed, but managed schema resource
> managed-schema not found - loading non-managed schema
> schema-id-and-version-fields-only.xml instead
> [junit4] 2> 1580 T11 oass.IndexSchema.readSchema Reading Solr Schema
> from
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
>
> F1A11DF972B907D6-002/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
> [junit4] 2> 1594 T11 oass.IndexSchema.readSchema [null] Schema
> name=id-and-version-fields-only
> [junit4] 2> 1676 T11 oass.IndexSchema.readSchema unique key field: id
> [junit4] 2> 1706 T11 oass.ManagedIndexSchema.persistManagedSchema
> Upgraded to managed schema at
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 1709 T11
> oass.ManagedIndexSchemaFactory.upgradeToManagedSchema After upgrading to
> managed schema, renamed the non-managed schema
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
>
> F1A11DF972B907D6-002/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
> to
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
>
> F1A11DF972B907D6-002/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml.bak
> [junit4] 2> 1714 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not
> configured for solr (NoInitialContextEx)
> [junit4] 2> 1715 T11 oasc.SolrResourceLoader.locateSolrHome using system
> property solr.solr.home:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001
> [junit4] 2> 1715 T11 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory:
> '/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/'
> [junit4] 2> 1765 T11 oasc.CoreContainer.<init> New CoreContainer
> 731222945
> [junit4] 2> 1767 T11 oasc.CoreContainer.load Loading cores into
> CoreContainer
> [instanceDir=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/]
> [junit4] 2> 1768 T11 oasc.CoreContainer.load loading shared library:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/lib
> [junit4] 2> 1769 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't
> find (or read) directory to add to classloader: lib (resolved as:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/lib).
> [junit4] 2> 1821 T11 oashc.HttpShardHandlerFactory.init created with
> socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost :
> 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
> 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
> false,useRetries : false,
> [junit4] 2> 2086 T11 oasu.UpdateShardHandler.<init> Creating
> UpdateShardHandler HTTP client with params:
> socketTimeout=30000&connTimeout=30000&retry=true
> [junit4] 2> 2093 T11 oasl.LogWatcher.createWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 2096 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering
> Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 2099 T11 oasc.CoreContainer.load Node Name: testNode
> [junit4] 2> 2100 T11 oasc.CoreContainer.initializeAuthenticationPlugin
> No authentication plugin used.
> [junit4] 2> 2265 T11 oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
> {dataDir=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001,
> config=solrconfig-managed-schema.xml, shard=shard1, collection=collection1,
> name=collection1, instanceDir=collection1, loadOnStartup=true,
> schema=managed-schema,
> absoluteInstDir=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/, transient=false}
> [junit4] 2> 2269 T12 oasc.SolrResourceLoader.<init> new
> SolrResourceLoader for directory:
> '/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/'
> [junit4] 2> 2309 T12 oasc.SolrConfig.refreshRequestParams current
> version of requestparams : -1
> [junit4] 2> 2335 T12 oasc.SolrConfig.<init> Using Lucene MatchVersion:
> 5.2.0
> [junit4] 2> 2372 T12 oasc.SolrConfig.<init> Loaded SolrConfig:
> solrconfig-managed-schema.xml
> [junit4] 2> 2373 T12 oass.IndexSchema.readSchema Reading Solr Schema
> from
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 2379 T12 oass.IndexSchema.readSchema [collection1] Schema
> name=id-and-version-fields-only
> [junit4] 2> 2396 T12 oass.IndexSchema.readSchema unique key field: id
> [junit4] 2> 2398 T12 oasc.CoreContainer.create Creating SolrCore
> 'collection1' using configuration from instancedir
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/
> [junit4] 2> 2401 T12 x:collection1 oasc.SolrCore.initDirectoryFactory
> solr.NRTCachingDirectoryFactory
> [junit4] 2> 2419 T12 x:collection1 oasc.SolrCore.<init> [[collection1] ]
> Opening new SolrCore at
> [/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/], dataDir=[null]
> [junit4] 2> 2420 T12 x:collection1 oasc.SolrCore.initInfoRegistry JMX
> monitoring not detected for core: collection1
> [junit4] 2> 2457 T12 x:collection1 oasc.CachingDirectoryFactory.get
> return new directory for
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001
> [junit4] 2> 2459 T12 x:collection1 oasc.SolrCore.getNewIndexDir New
> index directory detected: old=null
> new=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index/
> [junit4] 2> 2460 T12 x:collection1 oasc.SolrCore.initIndex WARN
> [collection1] Solr index directory
> '/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index' doesn't exist. Creating new
> index...
> [junit4] 2> 2470 T12 x:collection1 oasc.CachingDirectoryFactory.get
> return new directory for
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> [junit4] 2> 2472 T12 x:collection1 oasu.RandomMergePolicy.<init>
> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
> [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=34,
> maxMergedSegmentMB=49.7861328125, floorSegmentMB=1.3154296875,
> forceMergeDeletesPctAllowed=27.39707383380555, segmentsPerTier=28.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
> [junit4] 2> 2560 T12 x:collection1 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=1
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 2562 T12 x:collection1 oasc.SolrDeletionPolicy.updateCommits
> newest commit generation = 1
> [junit4] 2> 2874 T12 x:collection1
> oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain
> defined as default, creating implicit default
> [junit4] 2> 2905 T12 x:collection1 oasc.RequestHandlers.applyInitParams
> WARN INVALID paramSet a in requestHandler {type = requestHandler,name =
> /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
> [junit4] 2> 2968 T12 x:collection1 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 2977 T12 x:collection1 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 2979 T12 x:collection1 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 2981 T12 x:collection1 oashl.XMLLoader.init
> xsltCacheLifetimeSeconds=60
> [junit4] 2> 3012 T12 x:collection1
> oasc.RequestHandlers.initHandlersFromConfig Registered paths:
> /config,/schema,/dump,/admin/system,/update,/admin/plugins,/admin/luke,/admin/segments,/update/csv,/admin/ping,/admin/mbeans,/admin/properties,/admin/threads,/update/json/docs,/admin/file,/replication,/update/json,standard,/admin/logging,/get
> [junit4] 2> 3016 T12 x:collection1 oasc.SolrCore.initStatsCache Using
> default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 3036 T12 x:collection1 oasu.UpdateHandler.<init> Using
> UpdateLog implementation: org.apache.solr.update.UpdateLog
> [junit4] 2> 3037 T12 x:collection1 oasu.UpdateLog.init Initializing
> UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
> maxNumLogsToKeep=10 numVersionBuckets=65536
> [junit4] 2> 3051 T12 x:collection1 oasu.CommitTracker.<init> Hard
> AutoCommit: disabled
> [junit4] 2> 3052 T12 x:collection1 oasu.CommitTracker.<init> Soft
> AutoCommit: disabled
> [junit4] 2> 3056 T12 x:collection1 oasu.RandomMergePolicy.<init>
> RandomMergePolicy wrapping class
> org.apache.lucene.index.MockRandomMergePolicy:
> org.apache.lucene.index.MockRandomMergePolicy@7c491585
> [junit4] 2> 3069 T12 x:collection1 oasc.SolrDeletionPolicy.onInit
> SolrDeletionPolicy.onInit: commits: num=1
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 3069 T12 x:collection1 oasc.SolrDeletionPolicy.updateCommits
> newest commit generation = 1
> [junit4] 2> 3106 T12 x:collection1 oass.SolrIndexSearcher.<init> Opening
> Searcher@6d2fdb53[collection1] main
> [junit4] 2> 3120 T12 x:collection1
> oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage
> initialized to use dir:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/conf
> [junit4] 2> 3120 T12 x:collection1 oasr.RestManager.init Initializing
> RestManager with initArgs:
> {storageDir=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/conf}
> [junit4] 2> 3150 T12 x:collection1 oasr.ManagedResourceStorage.load
> Reading _rest_managed.json using
> file:dir=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/tempDir-001/collection1/conf
> [junit4] 2> 3150 T12 x:collection1 oasr.RestManager.init Initializing 0
> registered ManagedResources
> [junit4] 2> 3183 T12 x:collection1 oash.ReplicationHandler.inform
> Commits will be reserved for 10000
> [junit4] 2> 3184 T13 x:collection1 oasc.SolrCore.registerSearcher
> [collection1] Registered new searcher Searcher@6d2fdb53[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 3185 T12 x:collection1 oasu.UpdateLog.onFirstSearcher On
> first searcher opened, looking up max value of version field
> [junit4] 2> 3185 T12 x:collection1
> oasu.VersionInfo.getMaxVersionFromIndex Refreshing highest value of _version_
> for 65536 version buckets from index
> [junit4] 2> 3186 T12 x:collection1
> oasu.VersionInfo.getMaxVersionFromIndex No terms found for _version_, cannot
> seed version bucket highest value from index
> [junit4] 2> 3186 T12 x:collection1
> oasu.UpdateLog.seedBucketsWithHighestVersion Could not find max version in
> index or recent updates, using new clock 1502552624681975808
> [junit4] 2> 3190 T12 x:collection1
> oasu.UpdateLog.seedBucketsWithHighestVersion Took 4 ms to seed version
> buckets with highest version 1502552624681975808
> [junit4] 2> 3191 T12 x:collection1 oasc.CoreContainer.registerCore
> registering core: collection1
> [junit4] 2> 3199 T11 oas.SolrTestCaseJ4.initCore ####initCore end
> [junit4] 2> 3216 T11 oas.SolrTestCaseJ4.setUp ###Starting test
> [junit4] 2> ASYNC NEW_CORE C0 name=collection1
> org.apache.solr.core.SolrCore@b70de0f
> [junit4] 2> 3520 T11 C0 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {add=[1 (1502552624851845120)]} 0 301
> [junit4] 2> 3538 T11 C0 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {add=[2 (1502552625050025984)]} 0 1
> [junit4] 2> 3540 T11 C0 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {add=[3 (1502552625053171712)]} 0 0
> [junit4] 2> 3542 T11 C0 oasu.DirectUpdateHandler2.commit start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> ASYNC NEW_CORE C1 name=collection1
> org.apache.solr.core.SolrCore@b70de0f
> [junit4] 2> 3734 T11 C1 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2> 3734 T11 C1 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 2
> [junit4] 2> 3775 T11 C1 oass.SolrIndexSearcher.<init> Opening
> Searcher@65d06070[collection1] main
> [junit4] 2> 3778 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
> [junit4] 2> 3779 T13 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@65d06070[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)))}
> [junit4] 2> 3779 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {commit=} 0 237
> [junit4] 2> 3784 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {add=[4 (1502552625306927104)]} 0 2
> [junit4] 2> 3787 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {add=[5 (1502552625311121408)]} 0 1
> [junit4] 2> 3789 T11 C1 oasu.DirectUpdateHandler2.commit start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 3865 T11 C1 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2> 3867 T11 C1 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 3
> [junit4] 2> 3878 T11 C1 oass.SolrIndexSearcher.<init> Opening
> Searcher@ae918c9[collection1] main
> [junit4] 2> 3880 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
> [junit4] 2> 3880 T13 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@ae918c9[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}
> [junit4] 2> 3883 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {commit=} 0 94
> [junit4] 2> 4033 T11 C1 oasc.SolrCore.execute [collection1] webapp=null
> path=null params={q=*:*&rows=20&qt=standard&version=2.2&start=0} hits=5
> status=0 QTime=143
> [junit4] 2> 4054 T11 C1 oasu.DirectUpdateHandler2.commit start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 4063 T11 C1 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
> [junit4] 2> 4064 T11 C1 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 4
> [junit4] 2> 4068 T11 C1 oass.SolrIndexSearcher.<init> Opening
> Searcher@7ef4de5d[collection1] main
> [junit4] 2> 4069 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
> [junit4] 2> 4069 T13 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@7ef4de5d[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}
> [junit4] 2> 4070 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {commit=} 0 16
> [junit4] 2> 4074 T11 oas.SolrTestCaseJ4.tearDown ###Ending test
> [junit4] 2> 4209 T11 C1 oass.SolrIndexSearcher.<init> Opening
> Searcher@528db148[collection1] realtime
> [junit4] 2> 4210 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {deleteByQuery=*:* (-1502552625616257024)} 0
> 133
> [junit4] 2> 4212 T11 C1 oasu.DirectUpdateHandler2.commit start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 4215 T11 C1 oasc.SolrDeletionPolicy.onCommit
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56041a58;
> maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_5,generation=5}
> [junit4] 2> 4216 T11 C1 oasc.SolrDeletionPolicy.updateCommits newest
> commit generation = 5
> [junit4] 2> 4217 T11 C1 oass.SolrIndexSearcher.<init> Opening
> Searcher@e9a15d9[collection1] main
> [junit4] 2> 4217 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
> [junit4] 2> 4217 T13 oasc.SolrCore.registerSearcher [collection1]
> Registered new searcher Searcher@e9a15d9[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 4223 T11 C1 oasup.LogUpdateProcessor.finish [collection1]
> webapp=null path=null params={} {commit=} 0 11
> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherReuse
> -Dtests.method=test -Dtests.seed=F1A11DF972B907D6 -Dtests.multiplier=2
> -Dtests.nightly=true -Dtests.slow=true -Dtests.locale=sr -Dtests.timezone=GMT
> -Dtests.asserts=true -Dtests.file.encoding=UTF-8
> [junit4] FAILURE 1.05s | TestSearcherReuse.test <<<
> [junit4] > Throwable #1: java.lang.AssertionError: expected
> same:<Searcher@ae918c9[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}> was not:<Searcher@7ef4de5d[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C3)
> Uninverting(_2(5.2.0):c2)))}>
> [junit4] > at
> __randomizedtesting.SeedInfo.seed([F1A11DF972B907D6:79F52223DC456A2E]:0)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:104)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 4252 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
> [junit4] 2> 4252 T11 oasc.CoreContainer.shutdown Shutting down
> CoreContainer instance=731222945
> [junit4] 2> 4253 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore
> org.apache.solr.core.SolrCore@b70de0f
> [junit4] 2> 4254 T11 oasu.DirectUpdateHandler2.close closing
> DirectUpdateHandler2{commits=4,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=364,transaction_logs_total_number=3}
> [junit4] 2> 4254 T11 oasu.SolrCoreState.decrefSolrCoreState Closing
> SolrCoreState
> [junit4] 2> 4254 T11 oasu.DefaultSolrCoreState.closeIndexWriter
> SolrCoreState ref count has reached 0 - closing IndexWriter
> [junit4] 2> 4255 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing
> IndexWriter with IndexWriterCloser
> [junit4] 2> 4256 T11 oasc.SolrCore.closeSearcher [collection1] Closing
> main searcher on request.
> [junit4] 2> 4256 T11 oasc.CachingDirectoryFactory.close Closing
> NRTCachingDirectoryFactory - 2 directories currently being tracked
> [junit4] 2> 4257 T11 oasc.CachingDirectoryFactory.closeCacheValue
> looking to close
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001
> [CachedDir<<refCount=0;path=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001;done=false>>]
> [junit4] 2> 4257 T11 oasc.CachingDirectoryFactory.close Closing
> directory:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001
> [junit4] 2> 4258 T11 oasc.CachingDirectoryFactory.closeCacheValue
> looking to close
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> [CachedDir<<refCount=0;path=/Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index;done=false>>]
> [junit4] 2> 4258 T11 oasc.CachingDirectoryFactory.close Closing
> directory:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002/init-core-data-001/index
> [junit4] 2> NOTE: leaving temporary files on disk at:
> /Users/sarowe/svn/lucene/dev/branches/lucene_solr_5_2/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse
> F1A11DF972B907D6-002
> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
> docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {},
> locale=sr, timezone=GMT
> [junit4] 2> NOTE: Mac OS X 10.10.3 x86_64/Oracle Corporation 1.7.0_71
> (64-bit)/cpus=8,threads=1,free=200793376,total=255852544
> [junit4] 2> NOTE: All tests run in this JVM: [TestSearcherReuse]
> [junit4] Completed [1/1] in 4.51s, 1 test, 1 failure <<< FAILURES!
> [junit4]
> [junit4]
> [junit4] Tests with failures:
> [junit4] - org.apache.solr.search.TestSearcherReuse.test
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
