You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by "Hoss Man (JIRA)" <ji...@apache.org> on 2015/07/06 18:22:04 UTC
[jira] [Commented] (SOLR-7611) TestSearcherReuse failure
[ https://issues.apache.org/jira/browse/SOLR-7611?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14615266#comment-14615266 ]
Hoss Man commented on SOLR-7611:
--------------------------------
reply i sent to a jenkins fail earlier today, posting here as well for permemenant record...
{quote}
FWIW: Steve looked in to this a bit ago and filed SOLR-7611...
https://issues.apache.org/jira/browse/SOLR-7611
...my impression at the time was that LUCENE-6505 totally invalidated the
entire premise of the test, but i didn't spend that much time looking into
it. But then steve said he was able to reproduce some failures even after
he rolled back LUCENE-6505 -- which left me more confused.
I honestly have no idea what's going on and haven't really had time to
think about it any more.
I suspect that there may be 2 unrelated problems here that exhibit the
same symptoms...
1) something that's been broken a while that causes some seeds to fail.
2) mike's change in LUCENE-6505 which (seems to) eliminate the point of
the feature being tested here and as a result changed the test in a way
that may by making #1 happen more often (ie: with more seeds)
{quote}
> 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, typescript
>
>
> {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(776@smb.local).
> [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: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org