lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0_72) - Build # 15944 - Failure!
Date Sun, 21 Feb 2016 12:56:06 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/15944/
Java: 64bit/jdk1.8.0_72 -XX:+UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes

Error Message:
expected:<5> but was:<4>

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<4>
	at __randomizedtesting.SeedInfo.seed([BB829F4C6BD9C1C8:97FBDBC91E60096D]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes(DirectUpdateHandlerTest.java:299)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11365 lines...]
   [junit4] Suite: org.apache.solr.update.DirectUpdateHandlerTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1146337 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 1146337 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1146337 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1146338 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1146338 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1146338 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1146338 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1146355 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1146361 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1146375 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1146379 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1146438 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1146439 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1146440 WARN  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1146443 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1146444 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1146445 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1146445 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1146445 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 1146446 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1146446 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1146446 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 1859727785
   [junit4]   2> 1146446 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 1146446 WARN  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1146446 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-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> 1146447 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1146448 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1146448 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1146448 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1146448 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1146448 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema12.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1146449 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1146449 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1146449 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1146449 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1146449 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1146463 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1146471 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1146485 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1146489 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1146548 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1146549 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1146549 WARN  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1146551 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1146552 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1146554 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1146554 INFO  (coreLoadExecutor-4170-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1146554 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory
   [junit4]   2> 1146555 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/]
   [junit4]   2> 1146555 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c60d0b6
   [junit4]   2> 1146555 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1146556 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index/
   [junit4]   2> 1146556 WARN  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 1146556 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index
   [junit4]   2> 1146556 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=50.4404296875, floorSegmentMB=0.404296875, forceMergeDeletesPctAllowed=24.592680178598407, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1146610 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4de9fcb9),segFN=segments_1,generation=1}
   [junit4]   2> 1146610 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1146611 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1146615 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1146616 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1146616 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1146616 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1146618 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1146618 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1146619 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1146619 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1146622 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1146623 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1146623 WARN  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1146623 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1146624 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1146624 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1146624 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=10.984375, floorSegmentMB=2.001953125, forceMergeDeletesPctAllowed=20.314872767935864, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.155372564989169
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4de9fcb9),segFN=segments_1,generation=1}
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@79eb9ce4[collection1] main]
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1146625 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1146626 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1146662 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1146757 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1146757 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1146757 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1146757 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1146757 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1146757 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1146758 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1146758 INFO  (coreLoadExecutor-4170-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1146758 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1146758 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1146758 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1146758 INFO  (searcherExecutor-4171-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@79eb9ce4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1146759 INFO  (SUITE-DirectUpdateHandlerTest-seed#[BB829F4C6BD9C1C8]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1146762 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testAddRollback
   [junit4]   2> 1146762 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1146763 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1146765 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1147418 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4de9fcb9),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4de9fcb9),segFN=segments_2,generation=2}
   [junit4]   2> 1147419 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1147420 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@698e2d10[collection1] main]
   [junit4]   2> 1147420 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1147421 INFO  (searcherExecutor-4171-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@698e2d10[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1147422 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 656
   [junit4]   2> 1147422 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1147422 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1859727785
   [junit4]   2> 1147422 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@f2740f1
   [junit4]   2> 1147422 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 1147422 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1147422 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1147422 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1147423 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1147431 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockFSDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1147431 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 1147431 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index
   [junit4]   2> 1147431 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001;done=false>>]
   [junit4]   2> 1147431 INFO  (coreCloseExecutor-4175-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1147434 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1147451 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1147456 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1147469 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1147473 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1147519 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1147519 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1147520 WARN  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1147522 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1147523 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer New CoreContainer 1348419381
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 1147525 WARN  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1147525 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] 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> 1147526 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1147527 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1147527 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1147527 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1147527 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1147527 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema12.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1147527 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1147528 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1147528 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1147528 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1147528 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1147541 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1147547 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1147561 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1147564 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1147623 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1147624 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1147624 WARN  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1147627 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1147628 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1147630 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1147630 INFO  (coreLoadExecutor-4181-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1147630 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory
   [junit4]   2> 1147630 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/]
   [junit4]   2> 1147631 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c60d0b6
   [junit4]   2> 1147631 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1147631 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index/
   [junit4]   2> 1147632 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1147634 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1147636 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1147637 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1147638 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1147639 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1147641 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1147643 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1147643 WARN  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1147644 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1147647 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1147647 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1147648 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index
   [junit4]   2> 1147648 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=50.4404296875, floorSegmentMB=0.404296875, forceMergeDeletesPctAllowed=24.592680178598407, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1147649 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_2,generation=2}
   [junit4]   2> 1147649 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c58f100[collection1] main]
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1147650 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1147652 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1147652 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1147653 INFO  (coreLoadExecutor-4181-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1147653 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1147654 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1147654 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1147654 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1147656 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[A]} 0 1
   [junit4]   2> 1147657 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1147660 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1147660 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1147660 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1147660 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1147661 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1147661 INFO  (searcherExecutor-4182-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c58f100[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1147829 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_2,generation=2}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_3,generation=3}
   [junit4]   2> 1147830 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 1147832 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5db3a29b[collection1] main]
   [junit4]   2> 1147832 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1147834 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5db3a29b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
   [junit4]   2> 1147834 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[B]} 0 0
   [junit4]   2> 1147835 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start rollback{}
   [junit4]   2> 1147835 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 1147835 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=10.787109375, floorSegmentMB=1.080078125, forceMergeDeletesPctAllowed=13.6790525275325, segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.46385558680519257
   [junit4]   2> 1147836 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_3,generation=3}
   [junit4]   2> 1147836 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 1147836 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1147836 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_rollback
   [junit4]   2> 1147837 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:A+OR+id:B&indent=true} hits=1 status=0 QTime=0
   [junit4]   2> 1147838 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[ZZZ]} 0 0
   [junit4]   2> 1147838 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148057 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_3,generation=3}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_4,generation=4}
   [junit4]   2> 1148057 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 1148060 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@262246b5[collection1] main]
   [junit4]   2> 1148060 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148061 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@262246b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))}
   [junit4]   2> 1148061 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 222
   [junit4]   2> 1148061 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=id:ZZZ&wt=xml} hits=1 status=0 QTime=0
   [junit4]   2> 1148062 INFO  (TEST-DirectUpdateHandlerTest.testAddRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testAddRollback
   [junit4]   2> 1148064 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testPostSoftCommitEvents
   [junit4]   2> 1148065 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1148065 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1148065 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148093 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_4,generation=4}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_5,generation=5}
   [junit4]   2> 1148093 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 5
   [junit4]   2> 1148093 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@57859e43[collection1] main]
   [junit4]   2> 1148093 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148095 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57859e43[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1148096 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 30
   [junit4]   2> 1148097 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[999]} 0 0
   [junit4]   2> 1148097 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 1148100 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6751acc5[collection1] main]
   [junit4]   2> 1148100 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148101 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6751acc5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C1)))}
   [junit4]   2> 1148101 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 1148102 INFO  (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testPostSoftCommitEvents
   [junit4]   2> 1148105 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRequireUniqueKey
   [junit4]   2> 1148105 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1148105 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1148106 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148159 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_5,generation=5}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_6,generation=6}
   [junit4]   2> 1148159 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 6
   [junit4]   2> 1148159 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7e61fbc0[collection1] main]
   [junit4]   2> 1148160 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148161 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7e61fbc0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1148162 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 55
   [junit4]   2> 1148162 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 1148163 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{} 0 0
   [junit4]   2> 1148163 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 1148163 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{} 0 0
   [junit4]   2> 1148163 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.h.RequestHandlerBase Ignoring exception matching id
   [junit4]   2> 1148164 INFO  (TEST-DirectUpdateHandlerTest.testRequireUniqueKey-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRequireUniqueKey
   [junit4]   2> 1148167 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteRollback
   [junit4]   2> 1148167 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1148167 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1148168 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1148209 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_6,generation=6}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f37e771),segFN=segments_7,generation=7}
   [junit4]   2> 1148209 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 7
   [junit4]   2> 1148210 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4a01d7b2[collection1] main]
   [junit4]   2> 1148210 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1148210 INFO  (searcherExecutor-4182-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4a01d7b2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1148210 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 42
   [junit4]   2> 1148211 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1148211 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1348419381
   [junit4]   2> 1148211 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4ba7c003
   [junit4]   2> 1148211 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=6,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=1,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
   [junit4]   2> 1148211 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1148211 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1148211 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1148216 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1148224 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockFSDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1148224 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001;done=false>>]
   [junit4]   2> 1148224 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1148224 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 1148224 INFO  (coreCloseExecutor-4186-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1148227 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1148247 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1148253 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1148279 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1148282 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1148336 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1148337 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1148337 WARN  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1148340 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1148341 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1148342 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1148342 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1148342 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 1148342 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1148342 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1148343 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer New CoreContainer 1910789162
   [junit4]   2> 1148343 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 1148343 WARN  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1148343 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] 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> 1148344 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1148344 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1148344 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1148344 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1148344 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1148345 INFO  (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[BB829F4C6BD9C1C8]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema12.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1148345 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1148345 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1148345 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1148346 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1148346 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1148358 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1148364 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1148378 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1148382 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1148466 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1148467 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1148467 WARN  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 1148470 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1148471 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1148473 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1148473 INFO  (coreLoadExecutor-4192-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1148473 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory
   [junit4]   2> 1148473 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/]
   [junit4]   2> 1148473 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c60d0b6
   [junit4]   2> 1148474 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1148474 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index/
   [junit4]   2> 1148474 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1148477 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1148479 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1148479 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1148480 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1148480 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1148482 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1148483 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 1148484 WARN  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1148484 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1148484 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1148484 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1148485 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index
   [junit4]   2> 1148485 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=50.4404296875, floorSegmentMB=0.404296875, forceMergeDeletesPctAllowed=24.592680178598407, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1148486 INFO  (coreLoadExecutor-4192-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLock

[...truncated too long message...]

lr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7cf6ffb4),segFN=segments_j,generation=19}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7cf6ffb4),segFN=segments_k,generation=20}
   [junit4]   2> 1150328 INFO  (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 20
   [junit4]   2> 1150328 INFO  (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1150336 INFO  (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockFSDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1162446 ERROR (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Timeout waiting for all directory ref counts to be released - gave up waiting on CachedDir<<refCount=1;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index;done=false>>
   [junit4]   2> 1162446 ERROR (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Error closing directory:org.apache.solr.common.SolrException: Timeout waiting for all directory ref counts to be released - gave up waiting on CachedDir<<refCount=1;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001/index;done=false>>
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:187)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:135)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:130)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1162446 INFO  (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001;done=false>>]
   [junit4]   2> 1162446 INFO  (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001/init-core-data-001
   [junit4]   2> 1162447 ERROR (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.SolrCore java.lang.AssertionError: 1
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:135)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:130)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1162447 ERROR (coreCloseExecutor-4197-thread-1) [    x:collection1] o.a.s.c.SolrCores Error shutting down core:java.lang.AssertionError: 1
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:135)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:130)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.update.DirectUpdateHandlerTest_BB829F4C6BD9C1C8-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {id=PostingsFormat(name=Memory doPackFST= false)}, docValues:{}, sim=ClassicSimilarity, locale=vi, timezone=America/Whitehorse
   [junit4]   2> NOTE: Linux 3.19.0-47-generic amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=12,threads=1,free=322171064,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SpellCheckCollatorTest, TestRawResponseWriter, LoggingHandlerTest, HdfsThreadLeakTest, ZkCLITest, UUIDUpdateProcessorFallbackTest, TestFieldSortValues, FastVectorHighlighterTest, TriLevelCompositeIdRoutingTest, TestCloudManagedSchemaConcurrent, MultiThreadedOCPTest, TestSystemIdResolver, SecurityConfHandlerTest, TestSortingResponseWriter, TestSolrQueryParserResource, ZkStateReaderTest, CoreAdminRequestStatusTest, TestMiniSolrCloudClusterSSL, TestQuerySenderNoQuery, DistributedMLTComponentTest, ExplicitHLLTest, TestRecoveryHdfs, DateRangeFieldTest, TestSolrDynamicMBean, BasicFunctionalityTest, SpatialRPTFieldTypeTest, HdfsRecoveryZkTest, CollectionsAPIAsyncDistributedZkTest, TestRestManager, TestCopyFieldCollectionResource, DistributedTermsComponentTest, CollectionReloadTest, ReplicationFactorTest, DistributedQueryComponentCustomSortTest, TestInfoStreamLogging, SchemaVersionSpecificBehaviorTest, TestUseDocValuesAsStored2, SortSpecParsingTest, GraphQueryTest, ChaosMonkeyNothingIsSafeTest, DistributedFacetPivotSmallAdvancedTest, OpenExchangeRatesOrgProviderTest, SolrCmdDistributorTest, HdfsWriteToMultipleCollectionsTest, SolrInfoMBeanTest, TestLMJelinekMercerSimilarityFactory, TestInitQParser, SpellCheckComponentTest, ShardRoutingTest, ClusterStateUpdateTest, IndexBasedSpellCheckerTest, TestSurroundQueryParser, TestUpdate, TestPerFieldSimilarityClassic, TestSimpleQParserPlugin, OverseerTaskQueueTest, TestQuerySenderListener, DistanceFunctionTest, TestBinaryResponseWriter, VersionInfoTest, HdfsBasicDistributedZkTest, MBeansHandlerTest, TestWordDelimiterFilterFactory, TestClassicSimilarityFactory, HdfsCollectionsAPIDistributedZkTest, ForceLeaderTest, TestRandomCollapseQParserPlugin, TestStressVersions, TestReqParamsAPI, TestSimpleTrackingShardHandler, TermsComponentTest, TestSolrConfigHandlerCloud, ShardRoutingCustomTest, TestCodecSupport, TestCursorMarkWithoutUniqueKey, SolrCloudExampleTest, BlockJoinFacetDistribTest, ConjunctionSolrSpellCheckerTest, HdfsDirectoryTest, SpatialFilterTest, DistributedIntervalFacetingTest, TestMacros, TestDocBasedVersionConstraints, SuggestComponentTest, SolrPluginUtilsTest, TestSchemaVersionResource, TestPivotHelperCode, AliasIntegrationTest, TestShortCircuitedRequests, DocValuesTest, TestOrdValues, TestPartialUpdateDeduplication, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, BasicZkTest, TestRandomFaceting, LeaderElectionTest, TestZkChroot, TestRandomDVFaceting, TestDistributedGrouping, TestHashPartitioner, ZkControllerTest, TestRealTimeGet, HardAutoCommitTest, PeerSyncTest, ConvertedLegacyTest, TestSort, TestFunctionQuery, DirectUpdateHandlerTest]
   [junit4] Completed [321/579 (1!)] on J1 in 16.13s, 7 tests, 1 failure <<< FAILURES!

[...truncated 856 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:740: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:684: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:524: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1457: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1014: There were test failures: 579 suites (8 ignored), 2331 tests, 1 failure, 117 ignored (72 assumptions) [seed: BB829F4C6BD9C1C8]

Total time: 49 minutes 0 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



Mime
View raw message