Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5225/ Java: 32bit/jdk1.8.0_60 -client -XX:+UseSerialGC
1 tests failed. FAILED: org.apache.solr.search.TestStressUserVersions.testStressReorderVersions Error Message: Captured an uncaught exception in thread: Thread[id=21986, name=READER3, state=RUNNABLE, group=TGRP-TestStressUserVersions] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=21986, name=READER3, state=RUNNABLE, group=TGRP-TestStressUserVersions] at __randomizedtesting.SeedInfo.seed([E91ADE7A45E625A0:F5DCE76C4F2DA12D]:0) Caused by: java.lang.RuntimeException: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([E91ADE7A45E625A0]:0) at org.apache.solr.search.TestStressUserVersions$2.run(TestStressUserVersions.java:302) Caused by: java.lang.AssertionError at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.search.TestStressUserVersions$2.run(TestStressUserVersions.java:293) Build Log: [...truncated 10982 lines...] [junit4] Suite: org.apache.solr.search.TestStressUserVersions [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001 [junit4] 2> 2920998 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 2920999 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2921000 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2921000 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2921000 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2921028 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2921032 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 2921039 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-externalversionconstraint.xml [junit4] 2> 2921040 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml [junit4] 2> 2921057 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2921147 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2921149 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2921151 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2921154 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2921164 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 2921164 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr [junit4] 2> 2921164 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\' [junit4] 2> 2921182 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 25103217 [junit4] 2> 2921182 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\] [junit4] 2> 2921182 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib [junit4] 2> 2921182 WARN (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib). [junit4] 2> 2921191 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 2921192 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 2921193 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2921193 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2921193 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2921193 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2921195 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-externalversionconstraint.xml, transient=false, schema=schema15.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=collection1, collection=collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001, shard=shard1} [junit4] 2> 2921195 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2921196 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2921196 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2921217 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2921221 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 2921237 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-externalversionconstraint.xml [junit4] 2> 2921237 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml [junit4] 2> 2921247 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2921323 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2921324 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2921325 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2921327 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2921335 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf' [junit4] 2> 2921335 INFO (coreLoadExecutor-9392-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\ [junit4] 2> 2921335 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2921335 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 2921335 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@c49839 [junit4] 2> 2921336 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\ [junit4] 2> 2921336 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index/ [junit4] 2> 2921337 WARN (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index' doesn't exist. Creating new index... [junit4] 2> 2921337 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index [junit4] 2> 2921337 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=11.5537109375, floorSegmentMB=1.24609375, forceMergeDeletesPctAllowed=3.041825737374052, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 2921338 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_1,generation=1} [junit4] 2> 2921338 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2921339 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\ [junit4] 2> 2921343 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "external-version-constraint" (default) [junit4] 2> 2921344 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "external-version-constraint" (default) [junit4] 2> 2921345 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "external-version-float" [junit4] 2> 2921345 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "external-version-float" [junit4] 2> 2921345 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "external-version-failhard" [junit4] 2> 2921345 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "external-version-failhard" [junit4] 2> 2921349 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2921350 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2921352 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2921353 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2921358 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 2921359 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2921360 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2921360 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2921361 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2921361 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2921362 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23580244735152445] [junit4] 2> 2921362 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_1,generation=1} [junit4] 2> 2921362 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2921363 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1bf1bd5[collection1] main [junit4] 2> 2921363 WARN (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead. [junit4] 2> 2921363 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 2921364 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2921364 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2921364 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2921365 INFO (searcherExecutor-9393-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1bf1bd5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2921366 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 2921366 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 2921366 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 2921366 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1511264495264071680 [junit4] 2> 2921368 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1511264495264071680 [junit4] 2> 2921368 INFO (coreLoadExecutor-9392-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2921369 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2921372 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStressReorderVersions [junit4] 2> 2921372 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 2921372 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@6f476d[collection1] realtime [junit4] 2> 2921372 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921373 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2921373 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_2,generation=2} [junit4] 2> 2921374 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 2921374 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@768ac9[collection1] main [junit4] 2> 2921374 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921375 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@768ac9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2921376 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=3 [junit4] 2> 2921379 INFO (TEST-TestStressUserVersions.testStressReorderVersions-seed#[E91ADE7A45E625A0]) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: commitPercent 8 softCommitPercent 60 deletePercent 16 deleteByQueryPercent 4 ndocs 181 nWriteThreads 22 percentRealtimeQuery 75 operations 10000 nReadThreads 14 [junit4] 2> 2921382 INFO (WRITER2) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 0 val= 2 version 2 [junit4] 2> 2921382 INFO (WRITER1) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 31 val= 2 version 3 [junit4] 2> 2921382 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit start [junit4] 2> 2921383 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2921382 INFO (WRITER0) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 0 val= 2 version 1 [junit4] 2> 2921382 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 0 val= 2 version 4 [junit4] 2> 2921401 INFO (WRITER7) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 0 val= 2 version 5 [junit4] 2> 2921401 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921402 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921402 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=68&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921403 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=170&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=115&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=179&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=30&wt=json} status=0 QTime=0 [junit4] 2> 2921403 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:108&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921404 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921402 INFO (WRITER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=2&versions=true&wt=json&indent=true} status=0 QTime=19 [junit4] 2> 2921404 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:75&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921404 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921402 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0 [junit4] 2> 2921404 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921405 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:128&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921405 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=99&wt=json} status=0 QTime=0 [junit4] 2> 2921405 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921406 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=111&wt=json} status=0 QTime=0 [junit4] 2> 2921406 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921404 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921406 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921407 INFO (WRITER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=1&versions=true&wt=json&indent=true} status=0 QTime=20 [junit4] 2> 2921407 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:22&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921407 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0 [junit4] 2> 2921407 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=74&wt=json} status=0 QTime=0 [junit4] 2> 2921407 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0 [junit4] 2> 2921408 INFO (WRITER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=6 [junit4] 2> 2921408 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=47&wt=json} status=0 QTime=0 [junit4] 2> 2921408 INFO (WRITER7) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit start [junit4] 2> 2921408 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 2 version 19 [junit4] 2> 2921408 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 2 version 18 [junit4] 2> 2921408 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 14 val= 2 version 12 [junit4] 2> 2921409 INFO (WRITER13) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 2 version 11 [junit4] 2> 2921409 INFO (WRITER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=12&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921409 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 14 val= 2 version 12 DONE [junit4] 2> 2921409 INFO (WRITER18) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921410 INFO (WRITER20) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921410 INFO (WRITER9) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 98 val= 2 version 7 [junit4] 2> 2921410 INFO (WRITER3) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_3,generation=3} [junit4] 2> 2921404 INFO (WRITER2) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 0 val= 2 version 2 DONE [junit4] 2> 2921410 INFO (WRITER3) [ ] o.a.s.c.SolrCore newest commit generation = 3 [junit4] 2> 2921410 INFO (WRITER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=7&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921404 INFO (WRITER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=20 [junit4] 2> 2921411 INFO (WRITER1) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 118 val= 2 version 25 [junit4] 2> 2921403 INFO (WRITER11) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 2921403 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=1 [junit4] 2> 2921403 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=2 [junit4] 2> 2921413 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0 [junit4] 2> 2921411 INFO (WRITER9) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 98 val= 2 version 7 DONE [junit4] 2> 2921413 INFO (WRITER9) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 178 val= 2 version 26 [junit4] 2> 2921414 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:97&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921410 INFO (WRITER2) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 90 val= 2 version 24 [junit4] 2> 2921414 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0 [junit4] 2> 2921410 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 3 version 23 [junit4] 2> 2921410 INFO (WRITER8) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 2 version 6 [junit4] 2> 2921410 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 24 val= 2 version 8 [junit4] 2> 2921414 INFO (WRITER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921414 INFO (WRITER8) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 20 val= 2 version 27 [junit4] 2> 2921410 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 2 version 9 [junit4] 2> 2921410 INFO (WRITER12) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 2 version 10 [junit4] 2> 2921415 INFO (WRITER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921415 INFO (WRITER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921410 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 3 version 22 [junit4] 2> 2921409 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 3 version 21 [junit4] 2> 2921409 INFO (WRITER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921416 INFO (WRITER13) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 30 [junit4] 2> 2921408 INFO (WRITER14) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 79 val= 2 version 13 [junit4] 2> 2921408 INFO (WRITER15) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 2 version 14 [junit4] 2> 2921408 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 17 val= 2 version 15 [junit4] 2> 2921408 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 2 version 16 [junit4] 2> 2921408 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 2 version 17 [junit4] 2> 2921408 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:129&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921417 INFO (WRITER19) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=17&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921417 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 2 version 17 DONE [junit4] 2> 2921417 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921408 INFO (WRITER21) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 2 version 20 [junit4] 2> 2921408 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:28&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921408 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921408 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921418 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:157&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921407 INFO (WRITER0) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 0 val= 2 version 1 DONE [junit4] 2> 2921419 INFO (WRITER0) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit start [junit4] 2> 2921419 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:51&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921407 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921419 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0 [junit4] 2> 2921419 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921419 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:136&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921419 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=74&wt=json} status=0 QTime=0 [junit4] 2> 2921407 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921420 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0 [junit4] 2> 2921407 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=49&wt=json} status=0 QTime=0 [junit4] 2> 2921407 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 QTime=1 [junit4] 2> 2921421 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921421 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0 [junit4] 2> 2921406 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0 [junit4] 2> 2921406 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=31&wt=json} status=0 QTime=0 [junit4] 2> 2921421 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=48&wt=json} status=0 QTime=0 [junit4] 2> 2921422 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:52&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921406 INFO (WRITER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=19 [junit4] 2> 2921422 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921405 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=147&wt=json} status=0 QTime=0 [junit4] 2> 2921422 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:160&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921423 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:118&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921405 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0 [junit4] 2> 2921423 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=135&wt=json} status=0 QTime=0 [junit4] 2> 2921423 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921423 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=79&wt=json} status=0 QTime=0 [junit4] 2> 2921422 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 55 val= 2 version 33 [junit4] 2> 2921422 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:159&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921421 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=50&wt=json} status=0 QTime=0 [junit4] 2> 2921421 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=51&wt=json} status=0 QTime=0 [junit4] 2> 2921425 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:16&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921425 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:50&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921420 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0 [junit4] 2> 2921420 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=160&wt=json} status=0 QTime=0 [junit4] 2> 2921420 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0 [junit4] 2> 2921426 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921419 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:125&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921426 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921418 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0 [junit4] 2> 2921418 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 3 version 32 [junit4] 2> 2921426 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=148&wt=json} status=0 QTime=0 [junit4] 2> 2921417 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 3 version 31 [junit4] 2> 2921417 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=14&wt=json} status=0 QTime=0 [junit4] 2> 2921415 INFO (WRITER12) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 122 val= 2 version 29 [junit4] 2> 2921427 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=58&wt=json} status=0 QTime=0 [junit4] 2> 2921415 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 63 val= 2 version 28 [junit4] 2> 2921414 INFO (WRITER3) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@6cde9a[collection1] main [junit4] 2> 2921414 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:94&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921428 INFO (WRITER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921428 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 55 val= 2 version 34 [junit4] 2> 2921428 INFO (WRITER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921429 INFO (WRITER12) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 4 val= 2 version 35 [junit4] 2> 2921429 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6cde9a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/1:delGen=1)))} [junit4] 2> 2921413 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=141&wt=json} status=0 QTime=0 [junit4] 2> 2921429 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=53&wt=json} status=0 QTime=0 [junit4] 2> 2921429 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0 [junit4] 2> 2921430 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=15&versions=true&wt=json&indent=true} status=0 QTime=13 [junit4] 2> 2921430 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 17 val= 2 version 15 DONE [junit4] 2> 2921430 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 172 val= 2 version 36 [junit4] 2> 2921430 INFO (WRITER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=14 [junit4] 2> 2921430 INFO (WRITER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=15 [junit4] 2> 2921431 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 4 version 37 [junit4] 2> 2921431 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=4 [junit4] 2> 2921431 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 39 [junit4] 2> 2921429 INFO (WRITER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=4 [junit4] 2> 2921432 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 40 [junit4] 2> 2921432 INFO (WRITER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=8&versions=true&wt=json&indent=true} status=0 QTime=17 [junit4] 2> 2921432 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 24 val= 2 version 8 DONE [junit4] 2> 2921428 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0 [junit4] 2> 2921428 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921433 INFO (WRITER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=50 [junit4] 2> 2921427 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0 [junit4] 2> 2921434 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0 [junit4] 2> 2921427 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0 [junit4] 2> 2921434 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0 [junit4] 2> 2921435 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:102&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921435 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:129&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921436 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=123&wt=json} status=0 QTime=0 [junit4] 2> 2921436 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921436 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:47&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921437 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=70&wt=json} status=0 QTime=0 [junit4] 2> 2921437 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=34&wt=json} status=0 QTime=0 [junit4] 2> 2921437 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=142&wt=json} status=0 QTime=0 [junit4] 2> 2921437 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921426 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=0 [junit4] 2> 2921438 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921426 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=24&wt=json} status=0 QTime=0 [junit4] 2> 2921426 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=149&wt=json} status=0 QTime=0 [junit4] 2> 2921425 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0 [junit4] 2> 2921425 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=144&wt=json} status=0 QTime=0 [junit4] 2> 2921425 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0 [junit4] 2> 2921439 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921424 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=19&wt=json} status=0 QTime=0 [junit4] 2> 2921424 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=153&wt=json} status=0 QTime=0 [junit4] 2> 2921424 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:30&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921423 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=179&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921440 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=43&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921440 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=95&wt=json} status=0 QTime=0 [junit4] 2> 2921440 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=21&wt=json} status=0 QTime=0 [junit4] 2> 2921439 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0 [junit4] 2> 2921439 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=147&wt=json} status=0 QTime=0 [junit4] 2> 2921442 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0 [junit4] 2> 2921439 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=33&wt=json} status=0 QTime=0 [junit4] 2> 2921438 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=170&wt=json} status=0 QTime=0 [junit4] 2> 2921438 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=97&wt=json} status=0 QTime=0 [junit4] 2> 2921438 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0 [junit4] 2> 2921443 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:155&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921443 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0 [junit4] 2> 2921438 INFO (WRITER11) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@a44600[collection1] main [junit4] 2> 2921443 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0 [junit4] 2> 2921444 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:89&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921436 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit end [junit4] 2> 2921444 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 42 [junit4] 2> 2921444 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a44600[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=1) Uninverting(_2(6.0.0):c20/5:delGen=1)))} [junit4] 2> 2921434 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2921445 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=91&wt=json} status=0 QTime=1 [junit4] 2> 2921445 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=115&wt=json} status=0 QTime=0 [junit4] 2> 2921434 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:78&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921446 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=2 [junit4] 2> 2921447 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=1 [junit4] 2> 2921447 INFO (WRITER19) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=31&versions=true&wt=json&indent=true} status=0 QTime=20 [junit4] 2> 2921448 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 3 version 31 DONE [junit4] 2> 2921448 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 43 [junit4] 2> 2921448 INFO (WRITER7) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@164d236 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10d1061),segFN=segments_4,generation=4} [junit4] 2> 2921449 INFO (WRITER7) [ ] o.a.s.c.SolrCore newest commit generation = 4 [junit4] 2> 2921433 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921450 INFO (WRITER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=20&versions=true&wt=json&indent=true} status=0 QTime=31 [junit4] 2> 2921433 INFO (WRITER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=19 [junit4] 2> 2921433 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 9 val= 2 version 41 [junit4] 2> 2921433 INFO (WRITER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=19 [junit4] 2> 2921432 INFO (WRITER20) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=18 [junit4] 2> 2921432 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921452 INFO (WRITER9) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit start [junit4] 2> 2921432 INFO (WRITER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921453 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 87 val= 2 version 47 [junit4] 2> 2921453 INFO (WRITER7) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@e6fa19[collection1] main [junit4] 2> 2921432 INFO (WRITER15) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=14 [junit4] 2> 2921431 INFO (WRITER8) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 135 val= 2 version 38 [junit4] 2> 2921431 INFO (WRITER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921454 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 14 val= 5 version 49 [junit4] 2> 2921454 INFO (WRITER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=47&versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921454 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 87 val= 2 version 47 DONE [junit4] 2> 2921430 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921454 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@e6fa19[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=2) Uninverting(_2(6.0.0):c20/7:delGen=2) Uninverting(_3(6.0.0):c1) Uninverting(_4(6.0.0):c1)))} [junit4] 2> 2921455 INFO (WRITER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=10 [junit4] 2> 2921455 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921430 INFO (WRITER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=14 [junit4] 2> 2921455 INFO (WRITER13) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 59 val= 2 version 52 [junit4] 2> 2921455 INFO (WRITER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=5 [junit4] 2> 2921456 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 176 val= 2 version 53 [junit4] 2> 2921430 INFO (WRITER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=13 [junit4] 2> 2921457 INFO (WRITER19) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=9 [junit4] 2> 2921457 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 75 val= 2 version 55 [junit4] 2> 2921457 INFO (WRITER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921430 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0 [junit4] 2> 2921430 INFO (WRITER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921457 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 133 val= 2 version 57 [junit4] 2> 2921458 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=100&wt=json} status=0 QTime=0 [junit4] 2> 2921458 INFO (WRITER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=57&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921429 INFO (WRITER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921458 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 133 val= 2 version 57 DONE [junit4] 2> 2921458 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 133 val= 3 version 58 [junit4] 2> 2921458 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=125&wt=json} status=0 QTime=0 [junit4] 2> 2921457 INFO (WRITER19) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921457 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 75 val= 2 version 56 [junit4] 2> 2921457 INFO (WRITER14) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 75 val= 2 version 54 [junit4] 2> 2921460 INFO (WRITER14) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=54&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921456 INFO (WRITER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=49&versions=true&wt=json&indent=true} status=0 QTime=3 [junit4] 2> 2921456 INFO (WRITER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921455 INFO (WRITER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=2 [junit4] 2> 2921455 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 2921455 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 60 val= 2 version 51 [junit4] 2> 2921455 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 87 val= 3 version 50 [junit4] 2> 2921455 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921461 INFO (WRITER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=53 [junit4] 2> 2921463 INFO (WRITER7) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit end [junit4] 2> 2921463 INFO (WRITER7) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 135 val= 3 version 62 [junit4] 2> 2921454 INFO (WRITER15) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 85 val= 2 version 48 [junit4] 2> 2921453 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 4 version 46 [junit4] 2> 2921453 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 178 val= 3 version 45 [junit4] 2> 2921452 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0 [junit4] 2> 2921466 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=107&wt=json} status=0 QTime=0 [junit4] 2> 2921467 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921452 INFO (WRITER21) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 2 version 20 DONE [junit4] 2> 2921467 INFO (WRITER21) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 4 version 63 [junit4] 2> 2921451 INFO (WRITER2) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 17 val= 3 version 44 [junit4] 2> 2921450 INFO (WRITER18) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=33 [junit4] 2> 2921450 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=3 [junit4] 2> 2921450 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=2 [junit4] 2> 2921470 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921470 INFO (WRITER3) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@173d197[collection1] main [junit4] 2> 2921470 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:25&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921446 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:27&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921445 INFO (WRITER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=33 [junit4] 2> 2921471 INFO (WRITER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=2 [junit4] 2> 2921471 INFO (WRITER2) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921471 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=6 [junit4] 2> 2921471 INFO (WRITER20) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=6 [junit4] 2> 2921443 INFO (WRITER11) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921472 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 5 version 67 [junit4] 2> 2921472 INFO (WRITER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=8 [junit4] 2> 2921472 INFO (WRITER7) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921473 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921473 INFO (WRITER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=4 [junit4] 2> 2921443 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=0 [junit4] 2> 2921442 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=54&wt=json} status=0 QTime=0 [junit4] 2> 2921442 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=18&wt=json} status=0 QTime=0 [junit4] 2> 2921473 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921473 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921442 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:34&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921442 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=27&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=112&wt=json} status=0 QTime=0 [junit4] 2> 2921475 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=129&wt=json} status=0 QTime=0 [junit4] 2> 2921441 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0 [junit4] 2> 2921473 INFO (WRITER21) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 6 version 68 [junit4] 2> 2921473 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921476 INFO (WRITER17) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 2921477 INFO (WRITER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921473 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=11 [junit4] 2> 2921477 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 7 version 70 [junit4] 2> 2921473 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 2921472 INFO (WRITER15) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=7 [junit4] 2> 2921478 INFO (WRITER15) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 85 val= 3 version 71 [junit4] 2> 2921472 INFO (WRITER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=69 [junit4] 2> 2921481 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit end [junit4] 2> 2921482 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 171 val= 2 version 72 [junit4] 2> 2921472 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 5 version 66 [junit4] 2> 2921482 INFO (WRITER20) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=66&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921482 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 109 val= 5 version 66 DONE [junit4] 2> 2921472 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@173d197[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=2) Uninverting(_2(6.0.0):c20/8:delGen=2) Uninverting(_3(6.0.0):c1) Uninverting(_6(6.0.0):c1) Uninverting(_5(6.0.0):c3) Uninverting(_7(6.0.0):c6/2:delGen=1)))} [junit4] 2> 2921471 INFO (WRITER2) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 2921471 INFO (WRITER1) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 37 val= 2 version 65 [junit4] 2> 2921484 INFO (WRITER20) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 171 val= 2 version 73 [junit4] 2> 2921487 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=173&wt=json} status=0 QTime=16 [junit4] 2> 2921471 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 130 val= 2 version 64 [junit4] 2> 2921488 INFO (WRITER17) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@14f53f2[collection1] main [junit4] 2> 2921488 INFO (WRITER17) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921489 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=14 [junit4] 2> 2921489 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:61&omitHeader=true&wt=json} hits=0 status=0 QTime=12 [junit4] 2> 2921471 INFO (WRITER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=9 [junit4] 2> 2921470 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:176&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921470 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921490 INFO (WRITER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=6 [junit4] 2> 2921467 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:24&omitHeader=true&wt=json} hits=1 status=0 QTime=0 [junit4] 2> 2921491 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14f53f2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=2) Uninverting(_2(6.0.0):c20/10:delGen=2) Uninverting(_6(6.0.0):c1) Uninverting(_5(6.0.0):c3/2) Uninverting(_7(6.0.0):c6/2:delGen=1) Uninverting(_8(6.0.0):c12/4:delGen=1)))} [junit4] 2> 2921491 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=166&wt=json} status=0 QTime=17 [junit4] 2> 2921491 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:37&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921491 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=143&wt=json} status=0 QTime=0 [junit4] 2> 2921492 INFO (WRITER17) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=14 [junit4] 2> 2921492 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:155&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921495 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=171&wt=json} status=0 QTime=4 [junit4] 2> 2921495 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=150&wt=json} status=0 QTime=6 [junit4] 2> 2921495 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=23&wt=json} status=0 QTime=0 [junit4] 2> 2921496 INFO (WRITER2) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1eb2179[collection1] main [junit4] 2> 2921466 INFO (WRITER0) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2921460 INFO (WRITER8) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 135 val= 3 version 61 [junit4] 2> 2921460 INFO (WRITER13) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 69 val= 2 version 60 [junit4] 2> 2921497 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit end [junit4] 2> 2921460 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 14 val= 5 version 49 DONE [junit4] 2> 2921460 INFO (WRITER14) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 75 val= 2 version 54 DONE [junit4] 2> 2921497 INFO (WRITER14) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 6 version 78 [junit4] 2> 2921460 INFO (WRITER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=56&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921459 INFO (WRITER19) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 75 val= 3 version 59 [junit4] 2> 2921459 INFO (READER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:39&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921459 INFO (WRITER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921458 INFO (WRITER12) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit start [junit4] 2> 2921498 INFO (WRITER6) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 15 val= 2 version 79 [junit4] 2> 2921498 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 75 val= 2 version 56 DONE [junit4] 2> 2921499 INFO (WRITER10) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 52 val= 2 version 80 [junit4] 2> 2921497 INFO (WRITER15) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=19 [junit4] 2> 2921497 INFO (WRITER5) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 14 val= 6 version 77 [junit4] 2> 2921497 INFO (WRITER17) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 37 val= 3 version 76 [junit4] 2> 2921497 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1eb2179[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=2) Uninverting(_2(6.0.0):c20/10:delGen=2) Uninverting(_6(6.0.0):c1) Uninverting(_5(6.0.0):c3/2) Uninverting(_7(6.0.0):c6/2:delGen=1) Uninverting(_8(6.0.0):c12/5:delGen=1) Uninverting(_9(6.0.0):c3)))} [junit4] 2> 2921497 INFO (WRITER2) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921496 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=164&wt=json} status=0 QTime=1 [junit4] 2> 2921501 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0 [junit4] 2> 2921501 INFO (READER0) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:27&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921496 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=36&wt=json} status=0 QTime=0 [junit4] 2> 2921502 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=37&wt=json} status=0 QTime=0 [junit4] 2> 2921502 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0 [junit4] 2> 2921496 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=172&wt=json} status=0 QTime=0 [junit4] 2> 2921504 INFO (READER5) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=0 [junit4] 2> 2921494 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=171&wt=json} status=0 QTime=4 [junit4] 2> 2921493 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=57&wt=json} status=0 QTime=3 [junit4] 2> 2921493 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=55&wt=json} status=0 QTime=3 [junit4] 2> 2921506 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:148&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921507 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=145&wt=json} status=0 QTime=0 [junit4] 2> 2921493 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=171&wt=json} status=0 QTime=3 [junit4] 2> 2921493 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=63&wt=json} status=0 QTime=1 [junit4] 2> 2921491 INFO (WRITER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=72&versions=true&wt=json&indent=true} status=0 QTime=8 [junit4] 2> 2921508 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 171 val= 2 version 72 DONE [junit4] 2> 2921508 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 0 val= 3 version 82 [junit4] 2> 2921508 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=22&wt=json} status=0 QTime=0 [junit4] 2> 2921491 INFO (WRITER1) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 37 val= 3 version 75 [junit4] 2> 2921490 INFO (WRITER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={} status=0 QTime=34 [junit4] 2> 2921490 INFO (WRITER18) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921510 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 130 val= 3 version 83 [junit4] 2> 2921490 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=1 status=0 QTime=15 [junit4] 2> 2921490 INFO (WRITER4) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 171 val= 2 version 74 [junit4] 2> 2921488 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=59&wt=json} status=0 QTime=12 [junit4] 2> 2921512 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0 [junit4] 2> 2921488 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=64&wt=json} status=0 QTime=12 [junit4] 2> 2921513 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:120&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921487 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=74&wt=json} status=0 QTime=10 [junit4] 2> 2921487 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=70&wt=json} status=0 QTime=10 [junit4] 2> 2921477 INFO (WRITER21) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 7 version 69 [junit4] 2> 2921514 INFO (READER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=166&wt=json} status=0 QTime=0 [junit4] 2> 2921514 INFO (READER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=130&wt=json} status=0 QTime=0 [junit4] 2> 2921513 INFO (READER4) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=93&wt=json} status=0 QTime=0 [junit4] 2> 2921516 INFO (WRITER21) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=1 [junit4] 2> 2921513 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:130&omitHeader=true&wt=json} hits=1 status=0 QTime=0 [junit4] 2> 2921512 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=16&wt=json} status=0 QTime=0 [junit4] 2> 2921517 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=139&wt=json} status=0 QTime=0 [junit4] 2> 2921518 INFO (READER7) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=109&wt=json} status=0 QTime=0 [junit4] 2> 2921518 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:109&omitHeader=true&wt=json} hits=1 status=0 QTime=0 [junit4] 2> 2921518 INFO (READER3) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=90&wt=json} status=0 QTime=0 [junit4] 2> 2921510 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: softCommit end [junit4] 2> 2921519 INFO (WRITER3) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 8 version 85 [junit4] 2> 2921510 INFO (WRITER7) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1554827[collection1] main [junit4] 2> 2921519 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 2921520 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=42 [junit4] 2> 2921520 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 8 version 86 [junit4] 2> 2921520 INFO (searcherExecutor-9393-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1554827[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c6/3:delGen=2) Uninverting(_2(6.0.0):c20/10:delGen=2) Uninverting(_5(6.0.0):c3/2) Uninverting(_7(6.0.0):c6/3:delGen=1) Uninverting(_8(6.0.0):c12/5:delGen=1) Uninverting(_9(6.0.0):c3/1) Uninverting(_a(6.0.0):c5)))} [junit4] 2> 2921521 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921521 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 109 val= 9 version 87 [junit4] 2> 2921522 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921522 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 157 val= 2 version 88 [junit4] 2> 2921522 INFO (WRITER16) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921523 INFO (WRITER16) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: hardCommit start [junit4] 2> 2921509 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=35&wt=json} status=0 QTime=0 [junit4] 2> 2921508 INFO (READER1) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=113&wt=json} status=0 QTime=0 [junit4] 2> 2921523 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:141&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921507 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:108&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921524 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=102&wt=json} status=0 QTime=0 [junit4] 2> 2921524 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0 [junit4] 2> 2921525 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=98&wt=json} status=0 QTime=0 [junit4] 2> 2921525 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=126&wt=json} status=0 QTime=0 [junit4] 2> 2921525 INFO (READER12) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=20&wt=json} status=0 QTime=0 [junit4] 2> 2921507 INFO (READER9) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=1 status=0 QTime=0 [junit4] 2> 2921506 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=75&wt=json} status=0 QTime=2 [junit4] 2> 2921506 INFO (READER6) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0 QTime=0 [junit4] 2> 2921526 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0 [junit4] 2> 2921527 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=178&wt=json} status=0 QTime=0 [junit4] 2> 2921506 INFO (WRITER8) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=8 [junit4] 2> 2921527 INFO (READER10) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=138&wt=json} status=0 QTime=0 [junit4] 2> 2921527 INFO (WRITER18) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={del_version=83&versions=true&wt=json&indent=true} status=0 QTime=16 [junit4] 2> 2921527 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: deleting id 130 val= 3 version 83 DONE [junit4] 2> 2921527 INFO (WRITER18) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 140 val= 2 version 90 [junit4] 2> 2921528 INFO (WRITER11) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=18 [junit4] 2> 2921528 INFO (WRITER11) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 157 val= 3 version 91 [junit4] 2> 2921528 INFO (WRITER18) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=0 [junit4] 2> 2921528 INFO (WRITER13) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} status=0 QTime=31 [junit4] 2> 2921529 INFO (WRITER13) [ ] o.a.s.SolrTestCaseJ4 VERBOSE: adding id 140 val= 3 version 93 [junit4] 2> 2921529 INFO (READER2) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&ids=157&wt=json} status=0 QTime=0 [junit4] 2> 2921530 INFO (WRIT [...truncated too long message...] lr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\;done=false>>] [junit4] 2> 2924515 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\ [junit4] 2> 2924515 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index;done=false>>] [junit4] 2> 2924515 INFO (SUITE-TestStressUserVersions-seed#[E91ADE7A45E625A0]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.search.TestStressUserVersions_E91ADE7A45E625A0-001\init-core-data-001\index [junit4] 2> NOTE: test params are: codec=Lucene53, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=cs, timezone=Asia/Krasnoyarsk [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_60 (32-bit)/cpus=3,threads=1,free=146867240,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [TestCloudManagedSchemaConcurrent, HdfsChaosMonkeySafeLeaderTest, TestCSVLoader, TestRemoteStreaming, OutOfBoxZkACLAndCredentialsProvidersTest, VMParamsZkACLAndCredentialsProvidersTest, TestDocBasedVersionConstraints, LeaderFailoverAfterPartitionTest, TestStressReorder, AsyncMigrateRouteKeyTest, TestReplicationHandler, PathHierarchyTokenizerFactoryTest, TestCloudInspectUtil, TestManagedResourceStorage, PrimitiveFieldTypeTest, TestStressLucene, TestSolrJ, SegmentsInfoRequestHandlerTest, TestFastWriter, TestConfigSets, FileUtilsTest, LeaderElectionTest, RemoteQueryErrorTest, AnalysisErrorHandlingTest, TestCloudManagedSchema, TestBlobHandler, DistributedExpandComponentTest, TestPseudoReturnFields, CursorMarkTest, TestFieldTypeResource, CoreMergeIndexesAdminHandlerTest, ExitableDirectoryReaderTest, HLLUtilTest, ShardRoutingTest, ConnectionManagerTest, DocumentBuilderTest, TestIntervalFaceting, HdfsThreadLeakTest, HardAutoCommitTest, SolrCoreTest, TestDocSet, TestStressVersions, TestComponentsName, TestInitParams, TestSortByMinMaxFunction, RecoveryAfterSoftCommitTest, SharedFSAutoReplicaFailoverUtilsTest, TestExactStatsCache, JSONWriterTest, SpatialFilterTest, TestDefaultSearchFieldResource, TestGroupingSearch, TestJmxIntegration, DistributedFacetPivotWhiteBoxTest, TestConfig, HdfsBasicDistributedZkTest, TestReqParamsAPI, DistributedVersionInfoTest, DistributedIntervalFacetingTest, DistributedFacetPivotSmallTest, TestSurroundQueryParser, HdfsCollectionsAPIDistributedZkTest, SmileWriterTest, CustomCollectionTest, CurrencyFieldXmlFileTest, TestSchemaSimilarityResource, SimpleCollectionCreateDeleteTest, HdfsSyncSliceTest, TestSolrXml, TermsComponentTest, FastVectorHighlighterTest, OverseerRolesTest, TestSolrConfigHandler, MigrateRouteKeyTest, RulesTest, SolrXmlInZkTest, AlternateDirectoryTest, QueryElevationComponentTest, SampleTest, HdfsBasicDistributedZk2Test, TestConfigSetProperties, TestSchemaManager, MBeansHandlerTest, TestQuerySenderNoQuery, RollingRestartTest, SyncSliceTest, DocValuesTest, DistributedQueryComponentOptimizationTest, TestPartialUpdateDeduplication, TestTrackingShardHandlerFactory, TestScoreJoinQPScore, TestImplicitCoreProperties, AnalysisAfterCoreReloadTest, TestDistributedMissingSort, TestNoOpRegenerator, SolrRequestParserTest, SuggestComponentTest, TestFieldCollectionResource, TestJettySolrRunner, HighlighterTest, TestFieldSortValues, DeleteReplicaTest, TestCodecSupport, TestRequestStatusCollectionAPI, TestRTGBase, TestSchemaNameResource, OverseerTest, CloudExitableDirectoryReaderTest, TestManagedSchemaDynamicFieldResource, StandardRequestHandlerTest, DistribDocExpirationUpdateProcessorTest, TestPostingsSolrHighlighter, JsonLoaderTest, TestCloudSchemaless, DeleteShardTest, TestCursorMarkWithoutUniqueKey, TestDistribIDF, TestLazyCores, DocumentAnalysisRequestHandlerTest, TestLMDirichletSimilarityFactory, CoreAdminRequestStatusTest, DirectUpdateHandlerTest, TestHashQParserPlugin, DeleteLastCustomShardedReplicaTest, SystemInfoHandlerTest, ZkNodePropsTest, TestSolrDeletionPolicy1, HLLSerializationTest, BadComponentTest, ExplicitHLLTest, BJQParserTest, TestRandomDVFaceting, TestExceedMaxTermLength, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, RecoveryZkTest, ClusterStateUpdateTest, ZkCLITest, AutoCommitTest, TestFaceting, TestRecovery, TestHashPartitioner, DistributedSpellCheckComponentTest, ZkControllerTest, TestRealTimeGet, TestReload, DistributedTermsComponentTest, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, PeerSyncTest, ConvertedLegacyTest, TestFunctionQuery, TestBadConfig, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, PolyFieldTest, NoCacheHeaderTest, TestUpdate, TestWordDelimiterFilterFactory, StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, SolrInfoMBeanTest, IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestQueryTypes, TestValueSourceCache, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, TestArbitraryIndexDir, RegexBoostProcessorTest, TestCollationField, ReturnFieldsTest, UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, SearchHandlerTest, SOLR749Test, UpdateParamsTest, TestSolrIndexConfig, SolrIndexConfigTest, TestStressRecovery, TestMergePolicyConfig, MultiTermTest, TestSearchPerf, MinimalSchemaTest, TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions, TestCharFilters, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestBM25SimilarityFactory, TestDefaultSimilarityFactory, TestJmxMonitoredMap, ResourceLoaderTest, OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, ConcurrentDeleteAndCreateCollectionTest, DeleteInactiveReplicaTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerTaskQueueTest, SSLMigrationTest, SaslZkACLProviderTest, SolrCloudExampleTest, TestAuthenticationFramework, TestCryptoKeys, TestDownShardTolerantSearch, TestMiniSolrCloudCluster, TestReplicaProperties, TestSolrCloudWithKerberosAlt, RuleEngineTest, CachingDirectoryFactoryTest, TestNRTOpen, TestShardHandlerFactory, RequestLoggingTest, TestReplicationHandlerBackup, TestSQLHandler, CoreAdminCreateDiscoverTest, InfoHandlerTest, DistributedDebugComponentTest, DistributedFacetPivotLargeTest, DistributedSuggestComponentTest, TestExpandComponent, TestPivotHelperCode, JavabinLoaderTest, HighlighterMaxOffsetTest, TestChildDocTransformer, TestRawResponseWriter, TestSortingResponseWriter, TestManagedResource, TestBulkSchemaAPI, TestClassNameShortening, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestDynamicFieldResource, TestFieldResource, TestFieldTypeCollectionResource, TestManagedSchemaFieldResource, TestManagedSchemaFieldTypeResource, TestRemoveLastDynamicCopyField, TestSchemaResource, TestSchemaVersionResource, TestSerializedLuceneMatchVersion, TestManagedStopFilterFactory, TestManagedSynonymFilterFactory, BadCopyFieldTest, ChangedSchemaMergeTest, DocValuesMissingTest, TestBulkSchemaConcurrent, TestCollationFieldDocValues, TestManagedSchema, AnalyticsMergeStrategyTest, MergeStrategyTest, TestAddFieldRealTimeGet, TestComplexPhraseQParserPlugin, TestInitQParser, TestOverriddenPrefixQueryForCustomFieldType, TestReloadDeadlock, TestSimpleQParserPlugin, TestStandardQParsers, TestStressUserVersions] [junit4] Completed [513/543] on J0 in 3.55s, 1 test, 1 error <<< FAILURES! [...truncated 101 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1432: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:987: There were test failures: 543 suites, 2147 tests, 1 error, 80 ignored (44 assumptions) Total time: 65 minutes 31 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org