Steve Rowe created SOLR-7611:
--------------------------------
Summary: 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
{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]
