You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/11/29 09:58:57 UTC
[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.7.0_45) - Build #
3441 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3441/
Java: 32bit/jdk1.7.0_45 -server -XX:+UseConcMarkSweepGC
1 tests failed.
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestBackup
Error Message:
Backup success not detected:<?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><lst name="details"><str name="indexSize">13.38 KB</str><str name="indexPath">C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714280252\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1385714282101</long><long name="generation">2</long><arr name="filelist"><str>_0.fdt</str><str>_0.fdx</str><str>_0.fnm</str><str>_0.si</str><str>_0_Lucene41_0.doc</str><str>_0_Lucene41_0.tim</str><str>_0_Lucene41_0.tip</str><str>_0_nrm.cfe</str><str>_0_nrm.cfs</str><str>_1.fdt</str><str>_1.fdx</str><str>_1.fnm</str><str>_1.si</str><str>_1_Lucene41_0.doc</str><str>_1_Lucene41_0.tim</str><str>_1_Lucene41_0.tip</str><str>_1_nrm.cfe</str><str>_1_nrm.cfs</str><str>_2.fdt</str><str>_2.fdx</str><str>_2.fnm</str><str>_2.si</str><str>_2_Lucene41_0.doc</str><str>_2_Lucene41_0.tim</str><str>_2_Lucene41_0.tip</str><str>_2_nrm.cfe</str><str>_2_nrm.cfs</str><str>segments_2</str></arr></lst></arr><str name="isMaster">true</str><str name="isSlave">false</str><long name="indexVersion">1385714282101</long><long name="generation">2</long><lst name="master"><str name="confFiles">schema-replication2.xml:schema.xml</str><arr name="replicateAfter"><str>commit</str></arr><str name="replicationEnabled">true</str><long name="replicableVersion">1385714282101</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Fri Nov 29 09:38:02 CET 2013</str><int name="fileCount">28</int><str name="status">success</str><str name="snapshotCompletedAt">Fri Nov 29 09:38:02 CET 2013</str></lst></lst><str name="WARNING">This response format is experimental. It is likely to change in the future.</str> </response>
Stack Trace:
java.lang.AssertionError: Backup success not detected:<?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><lst name="details"><str name="indexSize">13.38 KB</str><str name="indexPath">C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714280252\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1385714282101</long><long name="generation">2</long><arr name="filelist"><str>_0.fdt</str><str>_0.fdx</str><str>_0.fnm</str><str>_0.si</str><str>_0_Lucene41_0.doc</str><str>_0_Lucene41_0.tim</str><str>_0_Lucene41_0.tip</str><str>_0_nrm.cfe</str><str>_0_nrm.cfs</str><str>_1.fdt</str><str>_1.fdx</str><str>_1.fnm</str><str>_1.si</str><str>_1_Lucene41_0.doc</str><str>_1_Lucene41_0.tim</str><str>_1_Lucene41_0.tip</str><str>_1_nrm.cfe</str><str>_1_nrm.cfs</str><str>_2.fdt</str><str>_2.fdx</str><str>_2.fnm</str><str>_2.si</str><str>_2_Lucene41_0.doc</str><str>_2_Lucene41_0.tim</str><str>_2_Lucene41_0.tip</str><str>_2_nrm.cfe</str><str>_2_nrm.cfs</str><str>segments_2</str></arr></lst></arr><str name="isMaster">true</str><str name="isSlave">false</str><long name="indexVersion">1385714282101</long><long name="generation">2</long><lst name="master"><str name="confFiles">schema-replication2.xml:schema.xml</str><arr name="replicateAfter"><str>commit</str></arr><str name="replicationEnabled">true</str><long name="replicableVersion">1385714282101</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Fri Nov 29 09:38:02 CET 2013</str><int name="fileCount">28</int><str name="status">success</str><str name="snapshotCompletedAt">Fri Nov 29 09:38:02 CET 2013</str></lst></lst><str name="WARNING">This response format is experimental. It is likely to change in the future.</str>
</response>
at __randomizedtesting.SeedInfo.seed([96E2FE79A387129D:D769DE1C8439E1D2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.doTestBackup(TestReplicationHandler.java:1403)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:744)
Build Log:
[...truncated 10515 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 2369280 T6070 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterStartup
[junit4] 2> 2369296 T6070 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2369303 T6070 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50475
[junit4] 2> 2369303 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2369304 T6070 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2369304 T6070 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master
[junit4] 2> 2369304 T6070 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\'
[junit4] 2> 2369335 T6070 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\solr.xml
[junit4] 2> 2369431 T6070 oasc.CoreContainer.<init> New CoreContainer 11063966
[junit4] 2> 2369431 T6070 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\]
[junit4] 2> 2369434 T6070 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 2369435 T6070 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2369436 T6070 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 2369436 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2369436 T6070 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2369436 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2369436 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2369437 T6070 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2369437 T6070 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2369448 T6070 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2369451 T6070 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2369451 T6070 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2369460 T6080 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1
[junit4] 2> 2369460 T6080 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\'
[junit4] 2> 2369512 T6080 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 2369569 T6080 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2369569 T6080 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2369574 T6080 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2369592 T6080 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2369593 T6080 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2369593 T6080 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\
[junit4] 2> 2369593 T6080 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2369593 T6080 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\
[junit4] 2> 2369593 T6080 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index/
[junit4] 2> 2369593 T6080 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2369594 T6080 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index
[junit4] 2> 2369595 T6080 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5965142958626168]
[junit4] 2> 2369595 T6080 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1de4563 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b3fe18),segFN=segments_1,generation=1}
[junit4] 2> 2369595 T6080 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2369596 T6080 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2369596 T6080 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2369606 T6080 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2369609 T6080 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2369609 T6080 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2369609 T6080 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=63.0302734375, floorSegmentMB=2.0693359375, forceMergeDeletesPctAllowed=0.27989442886489524, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2369610 T6080 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1de4563 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b3fe18),segFN=segments_1,generation=1}
[junit4] 2> 2369610 T6080 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2369610 T6080 oass.SolrIndexSearcher.<init> Opening Searcher@1b52d1 main
[junit4] 2> 2369611 T6080 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2369611 T6080 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2369611 T6081 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b52d1 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 2369611 T6080 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2369612 T6070 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2369613 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2369625 T6070 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2369630 T6070 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50478
[junit4] 2> 2369630 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2369631 T6070 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2369631 T6070 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave
[junit4] 2> 2369631 T6070 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\'
[junit4] 2> 2369651 T6070 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\solr.xml
[junit4] 2> 2369703 T6070 oasc.CoreContainer.<init> New CoreContainer 18366290
[junit4] 2> 2369705 T6070 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\]
[junit4] 2> 2369706 T6070 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 2369706 T6070 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2369706 T6070 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2369707 T6070 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2369712 T6070 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2369712 T6070 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2369712 T6070 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2369718 T6092 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1
[junit4] 2> 2369718 T6092 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\'
[junit4] 2> 2369780 T6092 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 2369850 T6092 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2369850 T6092 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2369857 T6092 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2369874 T6092 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2369875 T6092 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2369876 T6092 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\
[junit4] 2> 2369876 T6092 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2369876 T6092 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\
[junit4] 2> 2369876 T6092 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index/
[junit4] 2> 2369876 T6092 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2369877 T6092 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index
[junit4] 2> 2369877 T6092 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5965142958626168]
[junit4] 2> 2369878 T6092 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@27144 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@801268),segFN=segments_1,generation=1}
[junit4] 2> 2369878 T6092 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2369879 T6092 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2369879 T6092 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2369880 T6092 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2369880 T6092 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2369880 T6092 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2369880 T6092 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2369881 T6092 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2369882 T6092 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2369885 T6092 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2369885 T6092 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2369886 T6092 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=63.0302734375, floorSegmentMB=2.0693359375, forceMergeDeletesPctAllowed=0.27989442886489524, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2369886 T6092 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@27144 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@801268),segFN=segments_1,generation=1}
[junit4] 2> 2369887 T6092 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2369887 T6092 oass.SolrIndexSearcher.<init> Opening Searcher@6b563c main
[junit4] 2> 2369892 T6092 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 2369892 T6092 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2369892 T6093 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b563c main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 2369893 T6070 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2369893 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2369904 T6070 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=18366290
[junit4] 2> 2369904 T6070 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5fef83
[junit4] 2> 2369905 T6070 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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=0,cumulative_errors=0}
[junit4] 2> 2369906 T6070 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2369906 T6070 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2369906 T6070 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2369907 T6070 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2369907 T6070 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2369907 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\;done=false>>]
[junit4] 2> 2369907 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\
[junit4] 2> 2369907 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index;done=false>>]
[junit4] 2> 2369907 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276625\slave\collection1\data\index
[junit4] 2> 2369909 T6070 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> ASYNC NEW_CORE C7882 name=collection1 org.apache.solr.core.SolrCore@58f466
[junit4] 2> 2369969 T6075 C7882 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2369970 T6075 C7882 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 1
[junit4] 2> 2369972 T6076 C7882 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2369973 T6076 C7882 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1de4563 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b3fe18),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1de4563 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b3fe18),segFN=segments_2,generation=2}
[junit4] 2> 2369974 T6076 C7882 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 2369974 T6076 C7882 oass.SolrIndexSearcher.<init> Opening Searcher@1120958 main
[junit4] 2> 2369974 T6076 C7882 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2369974 T6081 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1120958 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 2369977 T6076 C7882 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&softCommit=false&commit=true&version=2&wt=javabin} {commit=} 0 5
[junit4] 2> 2369989 T6070 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11063966
[junit4] 2> 2369991 T6070 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@58f466
[junit4] 2> 2369991 T6070 oasu.DirectUpdateHandler2.close 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> 2369991 T6070 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2369991 T6070 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2369991 T6070 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2369992 T6070 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2369993 T6070 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2369993 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index;done=false>>]
[junit4] 2> 2369993 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index
[junit4] 2> 2369993 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\;done=false>>]
[junit4] 2> 2369993 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\
[junit4] 2> 2369993 T6070 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2370045 T6070 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2370049 T6070 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50482
[junit4] 2> 2370050 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2370050 T6070 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2370051 T6070 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master
[junit4] 2> 2370051 T6070 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\'
[junit4] 2> 2370069 T6070 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\solr.xml
[junit4] 2> 2370138 T6070 oasc.CoreContainer.<init> New CoreContainer 1797914
[junit4] 2> 2370138 T6070 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\]
[junit4] 2> 2370141 T6070 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 2370141 T6070 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2370141 T6070 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 2370141 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2370141 T6070 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2370142 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2370142 T6070 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2370142 T6070 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2370143 T6070 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2370147 T6070 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2370148 T6070 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2370148 T6070 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 2370153 T6105 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1
[junit4] 2> 2370153 T6105 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\'
[junit4] 2> 2370204 T6105 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 2370268 T6105 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2370269 T6105 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2370274 T6105 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2370307 T6105 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2370309 T6105 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2370309 T6105 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\
[junit4] 2> 2370309 T6105 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2370310 T6105 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\
[junit4] 2> 2370310 T6105 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index/
[junit4] 2> 2370310 T6105 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2370311 T6105 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714276292\master\collection1\data\index
[junit4] 2> 2370311 T6105 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5965142958626168]
[junit4] 2> 2370311 T6105 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@114d8c7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1873a79),segFN=segments_1,generation=1}
[junit4] 2> 2370311 T6105 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2370314 T6105 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2370314 T6105 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2370315 T6105 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2370315 T6105 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2370315 T6105 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2370315 T6105 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2370316 T6105 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2370319 T6105 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2370322 T6105 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2370322 T6105 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2370322 T6105 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=63.0302734375, floorSegmentMB=2.0693359375, forceMergeDeletesPctAllowed=0.27989442886489524, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2370323 T6105 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@114d8c7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1873a79),segFN=segments_1,generation=1}
[junit4] 2> 2370323 T6105 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2370323 T6105 oass.SolrIndexSearcher.<init> Opening Searcher@1e30c0f main
[junit4] 2> 2370323 T6105 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 2370323 T6105 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2370325 T6105 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2370325 T6106 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e30c0f main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 2370326 T6070 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2370326 T6070 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C7883 name=collection1 org.apache.solr.core.SolrCore@1c542fa
[junit4] 2> 2370337 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0]} 0 0
[junit4] 2> 2370340 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1]} 0 0
[junit4] 2> 2370341 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[2]} 0 0
[junit4] 2> 2370343 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[3]} 0 0
[junit4] 2> 2370345 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[4]} 0 0
[junit4] 2> 2370347 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[5]} 0 0
[junit4] 2> 2370349 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[6]} 0 0
[junit4] 2> 2370351 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[7]} 0 0
[junit4] 2> 2370354 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[8]} 0 0
[junit4] 2> 2370356 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[9]} 0 0
[junit4] 2> 2370358 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[10]} 0 0
[junit4] 2> 2370361 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[11]} 0 0
[junit4] 2> 2370363 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[12]} 0 0
[junit4] 2> 2370365 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[13]} 0 0
[junit4] 2> 2370367 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[14]} 0 0
[junit4] 2> 2370371 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[15]} 0 0
[junit4] 2> 2370373 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[16]} 0 0
[junit4] 2> 2370378 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[17]} 0 0
[junit4] 2> 2370382 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[18]} 0 0
[junit4] 2> 2370384 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[19]} 0 0
[junit4] 2> 2370386 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[20]} 0 0
[junit4] 2> 2370389 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[21]} 0 0
[junit4] 2> 2370391 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[22]} 0 0
[junit4] 2> 2370393 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[23]} 0 0
[junit4] 2> 2370395 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[24]} 0 0
[junit4] 2> 2370397 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[25]} 0 0
[junit4] 2> 2370399 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[26]} 0 0
[junit4] 2> 2370401 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[27]} 0 0
[junit4] 2> 2370403 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[28]} 0 0
[junit4] 2> 2370405 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[29]} 0 0
[junit4] 2> 2370407 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[30]} 0 0
[junit4] 2> 2370410 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[31]} 0 0
[junit4] 2> 2370412 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[32]} 0 0
[junit4] 2> 2370414 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[33]} 0 0
[junit4] 2> 2370416 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[34]} 0 0
[junit4] 2> 2370418 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[35]} 0 0
[junit4] 2> 2370421 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[36]} 0 0
[junit4] 2> 2370423 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[37]} 0 0
[junit4] 2> 2370424 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[38]} 0 0
[junit4] 2> 2370427 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[39]} 0 0
[junit4] 2> 2370428 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[40]} 0 0
[junit4] 2> 2370430 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[41]} 0 0
[junit4] 2> 2370431 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[42]} 0 0
[junit4] 2> 2370434 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[43]} 0 1
[junit4] 2> 2370437 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[44]} 0 1
[junit4] 2> 2370440 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[45]} 0 0
[junit4] 2> 2370443 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[46]} 0 0
[junit4] 2> 2370446 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[47]} 0 0
[junit4] 2> 2370449 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[48]} 0 0
[junit4] 2> 2370452 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[49]} 0 1
[junit4] 2> 2370454 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[50]} 0 0
[junit4] 2> 2370458 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[51]} 0 1
[junit4] 2> 2370461 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[52]} 0 0
[junit4] 2> 2370464 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[53]} 0 0
[junit4] 2> 2370466 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[54]} 0 0
[junit4] 2> 2370469 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[55]} 0 1
[junit4] 2> 2370472 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[56]} 0 1
[junit4] 2> 2370475 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[57]} 0 0
[junit4] 2> 2370478 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[58]} 0 1
[junit4] 2> 2370480 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[59]} 0 0
[junit4] 2> 2370483 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[60]} 0 1
[junit4] 2> 2370487 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[61]} 0 1
[junit4] 2> 2370489 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[62]} 0 0
[junit4] 2> 2370492 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[63]} 0 0
[junit4] 2> 2370494 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[64]} 0 0
[junit4] 2> 2370497 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[65]} 0 1
[junit4] 2> 2370499 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[66]} 0 0
[junit4] 2> 2370502 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[67]} 0 0
[junit4] 2> 2370505 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[68]} 0 1
[junit4] 2> 2370508 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[69]} 0 0
[junit4] 2> 2370510 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[70]} 0 0
[junit4] 2> 2370513 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[71]} 0 0
[junit4] 2> 2370516 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[72]} 0 1
[junit4] 2> 2370520 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[73]} 0 0
[junit4] 2> 2370522 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[74]} 0 0
[junit4] 2> 2370524 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[75]} 0 0
[junit4] 2> 2370528 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[76]} 0 0
[junit4] 2> 2370531 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[77]} 0 0
[junit4] 2> 2370534 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[78]} 0 0
[junit4] 2> 2370537 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[79]} 0 0
[junit4] 2> 2370541 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[80]} 0 0
[junit4] 2> 2370544 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[81]} 0 0
[junit4] 2> 2370547 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[82]} 0 1
[junit4] 2> 2370550 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[83]} 0 0
[junit4] 2> 2370553 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[84]} 0 1
[junit4] 2> 2370557 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[85]} 0 1
[junit4] 2> 2370560 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[86]} 0 0
[junit4] 2> 2370562 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[87]} 0 0
[junit4] 2> 2370565 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[88]} 0 1
[junit4] 2> 2370568 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[89]} 0 0
[junit4] 2> 2370571 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[90]} 0 0
[junit4] 2> 2370574 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[91]} 0 0
[junit4] 2> 2370577 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[92]} 0 0
[junit4] 2> 2370580 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[93]} 0 0
[junit4] 2> 2370583 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[94]} 0 1
[junit4] 2> 2370586 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[95]} 0 0
[junit4] 2> 2370589 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[96]} 0 0
[junit4] 2> 2370592 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[97]} 0 0
[junit4] 2> 2370594 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[98]} 0 0
[junit4] 2> 2370597 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[99]} 0 0
[junit4] 2> 2370600 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[100]} 0 1
[junit4] 2> 2370603 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[101]} 0 1
[junit4] 2> 2370606 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[102]} 0 0
[junit4] 2> 2370609 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4] 2> 2370611 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[104]} 0 0
[junit4] 2> 2370614 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[105]} 0 1
[junit4] 2> 2370618 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[106]} 0 1
[junit4] 2> 2370620 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[107]} 0 0
[junit4] 2> 2370624 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[108]} 0 1
[junit4] 2> 2370627 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[109]} 0 0
[junit4] 2> 2370630 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[110]} 0 0
[junit4] 2> 2370632 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[111]} 0 0
[junit4] 2> 2370635 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[112]} 0 1
[junit4] 2> 2370638 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[113]} 0 0
[junit4] 2> 2370640 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[114]} 0 0
[junit4] 2> 2370642 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[115]} 0 0
[junit4] 2> 2370644 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[116]} 0 0
[junit4] 2> 2370648 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[117]} 0 1
[junit4] 2> 2370651 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4] 2> 2370653 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[119]} 0 0
[junit4] 2> 2370656 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[120]} 0 0
[junit4] 2> 2370658 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[121]} 0 0
[junit4] 2> 2370661 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[122]} 0 0
[junit4] 2> 2370664 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[123]} 0 1
[junit4] 2> 2370667 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[124]} 0 0
[junit4] 2> 2370670 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[125]} 0 0
[junit4] 2> 2370673 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[126]} 0 0
[junit4] 2> 2370676 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[127]} 0 0
[junit4] 2> 2370678 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[128]} 0 0
[junit4] 2> 2370681 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[129]} 0 1
[junit4] 2> 2370684 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[130]} 0 0
[junit4] 2> 2370686 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[131]} 0 0
[junit4] 2> 2370689 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[132]} 0 0
[junit4] 2> 2370692 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[133]} 0 0
[junit4] 2> 2370695 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[134]} 0 0
[junit4] 2> 2370698 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[135]} 0 0
[junit4] 2> 2370702 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[136]} 0 1
[junit4] 2> 2370705 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[137]} 0 1
[junit4] 2> 2370709 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[138]} 0 0
[junit4] 2> 2370712 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[139]} 0 0
[junit4] 2> 2370715 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[140]} 0 0
[junit4] 2> 2370718 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[141]} 0 0
[junit4] 2> 2370721 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[142]} 0 0
[junit4] 2> 2370723 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[143]} 0 0
[junit4] 2> 2370726 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[144]} 0 0
[junit4] 2> 2370729 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[145]} 0 0
[junit4] 2> 2370732 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[146]} 0 0
[junit4] 2> 2370735 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[147]} 0 1
[junit4] 2> 2370738 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[148]} 0 0
[junit4] 2> 2370740 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[149]} 0 0
[junit4] 2> 2370743 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[150]} 0 0
[junit4] 2> 2370746 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[151]} 0 0
[junit4] 2> 2370748 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[152]} 0 0
[junit4] 2> 2370750 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[153]} 0 0
[junit4] 2> 2370752 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[154]} 0 0
[junit4] 2> 2370754 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[155]} 0 0
[junit4] 2> 2370757 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[156]} 0 0
[junit4] 2> 2370760 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[157]} 0 1
[junit4] 2> 2370761 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[158]} 0 0
[junit4] 2> 2370763 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[159]} 0 0
[junit4] 2> 2370766 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[160]} 0 0
[junit4] 2> 2370768 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[161]} 0 0
[junit4] 2> 2370770 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[162]} 0 0
[junit4] 2> 2370772 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[163]} 0 0
[junit4] 2> 2370774 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[164]} 0 0
[junit4] 2> 2370776 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[165]} 0 0
[junit4] 2> 2370778 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[166]} 0 0
[junit4] 2> 2370780 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[167]} 0 0
[junit4] 2> 2370782 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[168]} 0 0
[junit4] 2> 2370787 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[169]} 0 0
[junit4] 2> 2370788 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[170]} 0 0
[junit4] 2> 2370789 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[171]} 0 0
[junit4] 2> 2370791 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[172]} 0 0
[junit4] 2> 2370792 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[173]} 0 0
[junit4] 2> 2370795 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[174]} 0 0
[junit4] 2> 2370797 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[175]} 0 0
[junit4] 2> 2370798 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[176]} 0 0
[junit4] 2> 2370801 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[177]} 0 0
[junit4] 2> 2370804 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[178]} 0 0
[junit4] 2> 2370808 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[179]} 0 0
[junit4] 2> 2370810 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[180]} 0 0
[junit4] 2> 2370812 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[181]} 0 0
[junit4] 2> 2370814 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[182]} 0 0
[junit4] 2> 2370817 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[183]} 0 0
[junit4] 2> 2370818 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[184]} 0 0
[junit4] 2> 2370820 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[185]} 0 0
[junit4] 2> 2370822 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[186]} 0 0
[junit4] 2> 2370824 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[187]} 0 0
[junit4] 2> 2370826 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[188]} 0 0
[junit4] 2> 2370828 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[189]} 0 0
[junit4] 2> 2370830 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[190]} 0 0
[junit4] 2> 2370832 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[191]} 0 0
[junit4] 2> 2370834 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[192]} 0 0
[junit4] 2> 2370836 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[193]} 0 0
[junit4] 2> 2370838 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[194]} 0 0
[junit4] 2> 2370841 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[195]} 0 0
[junit4] 2> 2370845 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[196]} 0 0
[junit4] 2> 2370848 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[197]} 0 0
[junit4] 2> 2370850 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[198]} 0 0
[junit4] 2> 2370852 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[199]} 0 0
[junit4] 2> 2370855 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[200]} 0 0
[junit4] 2> 2370857 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[201]} 0 0
[junit4] 2> 2370859 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[202]} 0 0
[junit4] 2> 2370862 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[203]} 0 0
[junit4] 2> 2370866 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[204]} 0 0
[junit4] 2> 2370867 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[205]} 0 0
[junit4] 2> 2370869 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[206]} 0 0
[junit4] 2> 2370871 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[207]} 0 0
[junit4] 2> 2370873 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[208]} 0 0
[junit4] 2> 2370877 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[209]} 0 0
[junit4] 2> 2370878 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[210]} 0 0
[junit4] 2> 2370880 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[211]} 0 0
[junit4] 2> 2370883 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[212]} 0 0
[junit4] 2> 2370885 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[213]} 0 0
[junit4] 2> 2370887 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[214]} 0 0
[junit4] 2> 2370890 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[215]} 0 0
[junit4] 2> 2370891 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[216]} 0 0
[junit4] 2> 2370894 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[217]} 0 0
[junit4] 2> 2370897 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[218]} 0 0
[junit4] 2> 2370901 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[219]} 0 0
[junit4] 2> 2370902 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[220]} 0 0
[junit4] 2> 2370904 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[221]} 0 0
[junit4] 2> 2370906 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[222]} 0 0
[junit4] 2> 2370908 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[223]} 0 0
[junit4] 2> 2370911 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[224]} 0 0
[junit4] 2> 2370913 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[225]} 0 0
[junit4] 2> 2370915 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[226]} 0 0
[junit4] 2> 2370918 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[227]} 0 1
[junit4] 2> 2370920 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[228]} 0 0
[junit4] 2> 2370922 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[229]} 0 0
[junit4] 2> 2370925 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[230]} 0 0
[junit4] 2> 2370928 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[231]} 0 1
[junit4] 2> 2370931 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[232]} 0 1
[junit4] 2> 2370933 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[233]} 0 1
[junit4] 2> 2370936 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[234]} 0 0
[junit4] 2> 2370939 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[235]} 0 0
[junit4] 2> 2370941 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[236]} 0 0
[junit4] 2> 2370944 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[237]} 0 0
[junit4] 2> 2370947 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[238]} 0 0
[junit4] 2> 2370951 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[239]} 0 1
[junit4] 2> 2370953 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[240]} 0 0
[junit4] 2> 2370956 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[241]} 0 1
[junit4] 2> 2370959 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[242]} 0 0
[junit4] 2> 2370962 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[243]} 0 0
[junit4] 2> 2370965 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[244]} 0 0
[junit4] 2> 2370968 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[245]} 0 1
[junit4] 2> 2370971 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[246]} 0 1
[junit4] 2> 2370974 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[247]} 0 0
[junit4] 2> 2370976 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[248]} 0 0
[junit4] 2> 2370979 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[249]} 0 0
[junit4] 2> 2370982 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[250]} 0 0
[junit4] 2> 2370985 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[251]} 0 0
[junit4] 2> 2370988 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[252]} 0 1
[junit4] 2> 2370991 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[253]} 0 1
[junit4] 2> 2370994 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[254]} 0 1
[junit4] 2> 2370997 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[255]} 0 1
[junit4] 2> 2371000 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[256]} 0 1
[junit4] 2> 2371002 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[257]} 0 0
[junit4] 2> 2371004 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[258]} 0 0
[junit4] 2> 2371007 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[259]} 0 0
[junit4] 2> 2371010 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[260]} 0 0
[junit4] 2> 2371013 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[261]} 0 1
[junit4] 2> 2371016 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[262]} 0 0
[junit4] 2> 2371018 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[263]} 0 0
[junit4] 2> 2371021 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[264]} 0 0
[junit4] 2> 2371024 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[265]} 0 0
[junit4] 2> 2371027 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[266]} 0 0
[junit4] 2> 2371030 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[267]} 0 0
[junit4] 2> 2371032 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[268]} 0 0
[junit4] 2> 2371036 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[269]} 0 1
[junit4] 2> 2371039 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[270]} 0 1
[junit4] 2> 2371042 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[271]} 0 1
[junit4] 2> 2371044 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[272]} 0 0
[junit4] 2> 2371047 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[273]} 0 0
[junit4] 2> 2371050 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[274]} 0 1
[junit4] 2> 2371053 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[275]} 0 0
[junit4] 2> 2371056 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[276]} 0 1
[junit4] 2> 2371058 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[277]} 0 0
[junit4] 2> 2371061 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[278]} 0 0
[junit4] 2> 2371063 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[279]} 0 0
[junit4] 2> 2371067 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[280]} 0 0
[junit4] 2> 2371070 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[281]} 0 0
[junit4] 2> 2371073 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[282]} 0 1
[junit4] 2> 2371076 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[283]} 0 0
[junit4] 2> 2371078 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[284]} 0 0
[junit4] 2> 2371082 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[285]} 0 0
[junit4] 2> 2371084 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[286]} 0 0
[junit4] 2> 2371086 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[287]} 0 0
[junit4] 2> 2371089 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[288]} 0 0
[junit4] 2> 2371093 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[289]} 0 0
[junit4] 2> 2371096 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[290]} 0 1
[junit4] 2> 2371098 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[291]} 0 0
[junit4] 2> 2371101 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[292]} 0 0
[junit4] 2> 2371105 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[293]} 0 1
[junit4] 2> 2371107 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[294]} 0 0
[junit4] 2> 2371110 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[295]} 0 0
[junit4] 2> 2371114 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[296]} 0 1
[junit4] 2> 2371117 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[297]} 0 0
[junit4] 2> 2371119 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[298]} 0 0
[junit4] 2> 2371122 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[299]} 0 1
[junit4] 2> 2371125 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[300]} 0 0
[junit4] 2> 2371128 T6101 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[301]} 0 1
[junit4] 2> 2371131 T6103 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[302]} 0 0
[junit4] 2> 2371133 T6104 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[303]} 0 0
[junit4] 2> 2371135 T6099 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[304]} 0 0
[junit4] 2> 2371138 T6100 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[305]} 0 0
[junit4] 2> 2371142 T6102 C7883 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[306]} 0
[...truncated too long message...]
index;done=false>>]
[junit4] 2> 2427245 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714330975\master\collection1\data\index
[junit4] 2> 2427245 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714330975\master\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714330975\master\collection1\data\;done=false>>]
[junit4] 2> 2427246 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714330975\master\collection1\data\
[junit4] 2> 2427248 T6070 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2427316 T6070 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11022595
[junit4] 2> 2427318 T6070 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@8d9ec8
[junit4] 2> 2427318 T6070 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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=0,cumulative_errors=0}
[junit4] 2> 2427319 T6070 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2427319 T6070 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2427320 T6070 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2427321 T6070 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2427321 T6070 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2427321 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\;done=false>>]
[junit4] 2> 2427321 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\
[junit4] 2> 2427321 T6070 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\index;done=false>>]
[junit4] 2> 2427321 T6070 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1385714331467\slave\collection1\data\index
[junit4] 2> 2427324 T6070 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2427412 T6070 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene41, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=es_HN, timezone=Africa/Tripoli
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_45 (32-bit)/cpus=2,threads=1,free=69551832,total=309960704
[junit4] 2> NOTE: All tests run in this JVM: [TimeZoneUtilsTest, SuggesterWFSTTest, LukeRequestHandlerTest, DistributedTermsComponentTest, EnumFieldTest, UUIDFieldTest, CoreMergeIndexesAdminHandlerTest, TestJoin, SpellingQueryConverterTest, DeleteShardTest, HdfsLockFactoryTest, PingRequestHandlerTest, AutoCommitTest, TestFileDictionaryLookup, TestFastLRUCache, TestStressRecovery, TestIndexingPerformance, PluginInfoTest, TestFaceting, TestMergePolicyConfig, SchemaVersionSpecificBehaviorTest, TestSolrXml, DistributedQueryComponentCustomSortTest, BasicDistributedZk2Test, AliasIntegrationTest, TestDistributedSearch, TestSerializedLuceneMatchVersion, CurrencyFieldOpenExchangeTest, DeleteInactiveReplicaTest, ExternalFileFieldSortTest, TestQueryTypes, TestUniqueKeyFieldResource, BadIndexSchemaTest, XmlUpdateRequestHandlerTest, TestIndexSearcher, TestRandomMergePolicy, PrimitiveFieldTypeTest, RequestHandlersTest, URLClassifyProcessorTest, BadComponentTest, TestSolrQueryParserResource, HighlighterConfigTest, TestSolrDeletionPolicy2, TestModifyConfFiles, TestHighFrequencyDictionaryFactory, TestCSVLoader, ResourceLoaderTest, TestNumberUtils, StandardRequestHandlerTest, XsltUpdateRequestHandlerTest, TestUpdate, TestPartialUpdateDeduplication, TestInfoStreamLogging, QueryParsingTest, TestStressLucene, TestAddFieldRealTimeGet, TestComponentsName, TestCollationFieldDocValues, TestSolrXmlPersistor, TestDistributedMissingSort, FileBasedSpellCheckerTest, TestCharFilters, JsonLoaderTest, PeerSyncTest, HighlighterTest, TestCopyFieldCollectionResource, ZkNodePropsTest, PathHierarchyTokenizerFactoryTest, ChaosMonkeyNothingIsSafeTest, TestSchemaResource, ZkCLITest, TestLazyCores, ClusterStateTest, SpellCheckComponentTest, TestGroupingSearch, HdfsBasicDistributedZkTest, HdfsSyncSliceTest, ShardRoutingTest, SampleTest, SuggesterTSTTest, ClusterStateUpdateTest, TestOmitPositions, MultiTermTest, TestNoOpRegenerator, TestRemoteStreaming, BasicFunctionalityTest, TestSolrXmlPersistence, TestZkChroot, TestDocBasedVersionConstraints, CurrencyFieldXmlFileTest, BlockCacheTest, TestCoreDiscovery, TestReversedWildcardFilterFactory, TestNonNRTOpen, DirectUpdateHandlerTest, ReturnFieldsTest, OutputWriterTest, TestRealTimeGet, LoggingHandlerTest, MBeansHandlerTest, TestSolrJ, TestRangeQuery, BadCopyFieldTest, TestPostingsSolrHighlighter, HdfsCollectionsAPIDistributedZkTest, SliceStateUpdateTest, TestFieldResource, ConvertedLegacyTest, TestSolrDeletionPolicy1, TestManagedSchema, CoreAdminHandlerTest, TestQuerySenderListener, TestStressUserVersions, TestLuceneMatchVersion, TestSolrQueryParser, BasicZkTest, StatsComponentTest, BJQParserTest, HdfsChaosMonkeySafeLeaderTest, NotRequiredUniqueKeyTest, TestLRUCache, TestSolrQueryParserDefaultOperatorResource, TestNRTOpen, CollectionsAPIDistributedZkTest, JSONWriterTest, TestElisionMultitermQuery, OverseerCollectionProcessorTest, UniqFieldsUpdateProcessorFactoryTest, CoreContainerCoreInitFailuresTest, TestDistributedGrouping, TestSolrIndexConfig, TestCodecSupport, TestPhraseSuggestions, DocValuesMultiTest, DistributedQueryElevationComponentTest, ShardSplitTest, TestDynamicFieldResource, UpdateParamsTest, AssignTest, WordBreakSolrSpellCheckerTest, PreAnalyzedUpdateProcessorTest, TestMultiCoreConfBootstrap, ShardRoutingCustomTest, TestSimpleQParserPlugin, TestFoldingMultitermQuery, LegacyHTMLStripCharFilterTest, TestSurroundQueryParser, QueryEqualityTest, TermVectorComponentTest, SolrIndexSplitterTest, UpdateRequestProcessorFactoryTest, TestCloudManagedSchema, FieldAnalysisRequestHandlerTest, TestFieldCollectionResource, ParsingFieldUpdateProcessorsTest, TestAnalyzedSuggestions, DocValuesMissingTest, PrimUtilsTest, DirectUpdateHandlerOptimizeTest, ChangedSchemaMergeTest, TestSchemaVersionResource, TestAtomicUpdateErrorCases, SolrCmdDistributorTest, TestBadConfig, TestSchemaNameResource, DateFieldTest, TestBinaryResponseWriter, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler]
[junit4] Completed in 58.16s, 14 tests, 1 failure <<< FAILURES!
[...truncated 515 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:426: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:406: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1279: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:912: There were test failures: 349 suites, 1516 tests, 1 failure, 39 ignored (11 assumptions)
Total time: 87 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_45 -server -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.7.0_45) - Build #
3442 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3442/
Java: 32bit/jdk1.7.0_45 -server -XX:+UseParallelGC
1 tests failed.
REGRESSION: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.testDistribSearch
Error Message:
this codec cannot write docvalues
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: this codec cannot write docvalues
at __randomizedtesting.SeedInfo.seed([C81099AE3516A8A6:49F617B64249C89A]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:491)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:197)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
at org.apache.solr.BaseDistributedSearchTestCase.commit(BaseDistributedSearchTestCase.java:496)
at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.doTest(DistributedQueryComponentCustomSortTest.java:63)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:843)
at sun.reflect.GeneratedMethodAccessor43.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:744)
Build Log:
[...truncated 10979 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest
[junit4] 2> 3392649 T10033 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /nqu/k
[junit4] 2> 3392650 T10033 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020
[junit4] 2> 3392654 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3392656 T10033 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3392658 T10033 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3392748 T10033 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3392821 T10033 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3392821 T10033 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3392829 T10033 oass.IndexSchema.readSchema [null] Schema name=test-custom-field-sort
[junit4] 2> 3392866 T10033 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3392869 T10033 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3392870 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3392870 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3392870 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3392885 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3392885 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3392885 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3392963 T10033 oasc.CoreContainer.<init> New CoreContainer 24701383
[junit4] 2> 3392963 T10033 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 3392965 T10033 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 3392965 T10033 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 3392966 T10033 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 3392966 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3392966 T10033 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3392966 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3392967 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3392967 T10033 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3392967 T10033 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3392977 T10033 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3392977 T10033 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3392977 T10033 oasc.CoreContainer.load Host Name:
[junit4] 2> 3392983 T10034 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 3392983 T10034 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3392983 T10034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3392983 T10034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3393050 T10034 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3393132 T10034 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3393133 T10034 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3393139 T10034 oass.IndexSchema.readSchema [collection1] Schema name=test-custom-field-sort
[junit4] 2> 3393172 T10034 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3393176 T10034 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3393177 T10034 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3393177 T10034 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\
[junit4] 2> 3393178 T10034 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ec595
[junit4] 2> 3393178 T10034 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\
[junit4] 2> 3393178 T10034 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\index/
[junit4] 2> 3393178 T10034 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\index' doesn't exist. Creating new index...
[junit4] 2> 3393178 T10034 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\index
[junit4] 2> 3393179 T10034 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 3393180 T10034 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1d4a1de lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1a7b37d)),segFN=segments_1,generation=1}
[junit4] 2> 3393180 T10034 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3393180 T10034 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 3393183 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3393184 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3393184 T10034 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 3393185 T10034 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 3393185 T10034 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3393185 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3393186 T10034 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3393186 T10034 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3393186 T10034 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3393187 T10034 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3393187 T10034 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3393187 T10034 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3393188 T10034 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3393188 T10034 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 3393189 T10034 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 3393189 T10034 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3393190 T10034 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3393190 T10034 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 3393190 T10034 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 3393191 T10034 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 3393191 T10034 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3393191 T10034 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393191 T10034 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393193 T10034 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393193 T10034 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393193 T10034 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393194 T10034 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393194 T10034 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393195 T10034 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393195 T10034 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 3393196 T10034 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 3393204 T10034 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3393207 T10034 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 3393211 T10034 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3393211 T10034 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3393211 T10034 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=50.6640625, floorSegmentMB=1.0888671875, forceMergeDeletesPctAllowed=28.390352486479202, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7906407559386093
[junit4] 2> 3393212 T10034 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1d4a1de lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1a7b37d)),segFN=segments_1,generation=1}
[junit4] 2> 3393212 T10034 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3393212 T10034 oass.SolrIndexSearcher.<init> Opening Searcher@a365d0 main
[junit4] 2> 3393213 T10034 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 3393222 T10034 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3393265 T10035 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a365d0 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 3393269 T10034 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3393279 T10033 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 3393284 T10033 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 3393287 T10033 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3393292 T10033 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63641
[junit4] 2> 3393292 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3393292 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3393292 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3393292 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3393318 T10033 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\solr.xml
[junit4] 2> 3393391 T10033 oasc.CoreContainer.<init> New CoreContainer 17622693
[junit4] 2> 3393392 T10033 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 3393394 T10033 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3393395 T10033 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 3393396 T10033 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3393397 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3393397 T10033 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3393398 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3393399 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3393399 T10033 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3393400 T10033 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3393411 T10033 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3393411 T10033 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3393412 T10033 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3393418 T10046 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 3393418 T10046 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3393420 T10046 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3393421 T10046 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3393483 T10046 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3393555 T10046 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3393555 T10046 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3393562 T10046 oass.IndexSchema.readSchema [collection1] Schema name=test-custom-field-sort
[junit4] 2> 3393597 T10046 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3393600 T10046 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3393601 T10046 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3393601 T10046 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/control/data\
[junit4] 2> 3393601 T10046 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ec595
[junit4] 2> 3393602 T10046 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/control/data\
[junit4] 2> 3393602 T10046 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/control/data\index/
[junit4] 2> 3393602 T10046 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652\control\data\index' doesn't exist. Creating new index...
[junit4] 2> 3393603 T10046 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/control/data\index
[junit4] 2> 3393604 T10046 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 3393604 T10046 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@106556c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7cf45)),segFN=segments_1,generation=1}
[junit4] 2> 3393604 T10046 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3393605 T10046 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 3393608 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3393608 T10046 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3393608 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3393609 T10046 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3393609 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3393609 T10046 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3393609 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3393610 T10046 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 3393610 T10046 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 3393610 T10046 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3393611 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3393611 T10046 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3393612 T10046 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3393612 T10046 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3393612 T10046 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3393612 T10046 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3393613 T10046 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3393613 T10046 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3393614 T10046 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 3393614 T10046 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 3393615 T10046 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3393615 T10046 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3393616 T10046 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 3393616 T10046 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 3393616 T10046 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 3393617 T10046 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3393618 T10046 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393618 T10046 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393619 T10046 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393620 T10046 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393620 T10046 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393620 T10046 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393620 T10046 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393621 T10046 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3393621 T10046 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 3393623 T10046 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 3393623 T10046 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3393626 T10046 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 3393632 T10046 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3393632 T10046 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3393633 T10046 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=50.6640625, floorSegmentMB=1.0888671875, forceMergeDeletesPctAllowed=28.390352486479202, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7906407559386093
[junit4] 2> 3393633 T10046 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@106556c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7cf45)),segFN=segments_1,generation=1}
[junit4] 2> 3393633 T10046 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3393634 T10046 oass.SolrIndexSearcher.<init> Opening Searcher@162cb27 main
[junit4] 2> 3393635 T10046 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 3393644 T10046 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3393688 T10047 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@162cb27 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 3393694 T10046 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3393695 T10033 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3393696 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3393702 T10033 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3393709 T10033 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63644
[junit4] 2> 3393710 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3393710 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3393711 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3393711 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3393746 T10033 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\solr.xml
[junit4] 2> 3393829 T10033 oasc.CoreContainer.<init> New CoreContainer 7629541
[junit4] 2> 3393829 T10033 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3393832 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3393834 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3393834 T10033 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3393834 T10033 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3393839 T10033 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3393841 T10033 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3393841 T10033 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3393851 T10058 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 3393851 T10058 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3393854 T10058 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3393855 T10058 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3393919 T10058 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3393992 T10058 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3393993 T10058 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3393998 T10058 oass.IndexSchema.readSchema [collection1] Schema name=test-custom-field-sort
[junit4] 2> 3394042 T10058 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3394044 T10058 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3394048 T10058 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3394048 T10058 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard0/data\
[junit4] 2> 3394048 T10058 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ec595
[junit4] 2> 3394048 T10058 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard0/data\
[junit4] 2> 3394048 T10058 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard0/data\index/
[junit4] 2> 3394048 T10058 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652\shard0\data\index' doesn't exist. Creating new index...
[junit4] 2> 3394050 T10058 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard0/data\index
[junit4] 2> 3394051 T10058 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 3394052 T10058 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@82a53c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b87aa)),segFN=segments_1,generation=1}
[junit4] 2> 3394052 T10058 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394053 T10058 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 3394056 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3394057 T10058 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3394057 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394058 T10058 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394058 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394058 T10058 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394058 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394059 T10058 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 3394059 T10058 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 3394059 T10058 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394059 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3394060 T10058 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394060 T10058 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394060 T10058 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3394060 T10058 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3394060 T10058 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3394062 T10058 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3394062 T10058 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3394062 T10058 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 3394062 T10058 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 3394063 T10058 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3394063 T10058 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3394064 T10058 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 3394064 T10058 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 3394064 T10058 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 3394066 T10058 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3394066 T10058 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394067 T10058 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394067 T10058 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394068 T10058 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394068 T10058 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394069 T10058 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394069 T10058 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394070 T10058 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394070 T10058 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 3394071 T10058 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 3394078 T10058 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3394080 T10058 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 3394087 T10058 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3394088 T10058 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3394088 T10058 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=50.6640625, floorSegmentMB=1.0888671875, forceMergeDeletesPctAllowed=28.390352486479202, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7906407559386093
[junit4] 2> 3394089 T10058 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@82a53c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2b87aa)),segFN=segments_1,generation=1}
[junit4] 2> 3394089 T10058 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394089 T10058 oass.SolrIndexSearcher.<init> Opening Searcher@12a3d20 main
[junit4] 2> 3394090 T10058 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 3394101 T10058 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3394149 T10059 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12a3d20 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 3394155 T10058 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3394156 T10033 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3394156 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3394166 T10033 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3394172 T10033 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63647
[junit4] 2> 3394175 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3394175 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3394175 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3394175 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3394202 T10033 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\solr.xml
[junit4] 2> 3394272 T10033 oasc.CoreContainer.<init> New CoreContainer 24600667
[junit4] 2> 3394272 T10033 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3394275 T10033 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3394281 T10033 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3394281 T10033 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3394281 T10033 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3394288 T10070 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 3394288 T10070 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3394291 T10070 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3394294 T10070 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3394357 T10070 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3394441 T10070 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3394441 T10070 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3394448 T10070 oass.IndexSchema.readSchema [collection1] Schema name=test-custom-field-sort
[junit4] 2> 3394482 T10070 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3394484 T10070 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3394486 T10070 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3394486 T10070 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard1/data\
[junit4] 2> 3394486 T10070 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ec595
[junit4] 2> 3394487 T10070 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard1/data\
[junit4] 2> 3394487 T10070 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard1/data\index/
[junit4] 2> 3394487 T10070 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652\shard1\data\index' doesn't exist. Creating new index...
[junit4] 2> 3394487 T10070 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard1/data\index
[junit4] 2> 3394488 T10070 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 3394489 T10070 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@ac48b5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1749d39)),segFN=segments_1,generation=1}
[junit4] 2> 3394489 T10070 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394490 T10070 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 3394493 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3394493 T10070 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3394493 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394494 T10070 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394494 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394494 T10070 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394494 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394495 T10070 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 3394495 T10070 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 3394496 T10070 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394496 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3394496 T10070 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394497 T10070 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394497 T10070 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3394497 T10070 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3394497 T10070 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3394497 T10070 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3394498 T10070 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3394498 T10070 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 3394500 T10070 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 3394500 T10070 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3394501 T10070 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3394501 T10070 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 3394501 T10070 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 3394501 T10070 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 3394502 T10070 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3394502 T10070 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394504 T10070 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394504 T10070 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394504 T10070 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394504 T10070 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394505 T10070 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394505 T10070 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394506 T10070 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394506 T10070 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 3394507 T10070 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 3394513 T10070 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3394515 T10070 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 3394520 T10070 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3394520 T10070 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3394521 T10070 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=50.6640625, floorSegmentMB=1.0888671875, forceMergeDeletesPctAllowed=28.390352486479202, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7906407559386093
[junit4] 2> 3394522 T10070 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@ac48b5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1749d39)),segFN=segments_1,generation=1}
[junit4] 2> 3394522 T10070 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394522 T10070 oass.SolrIndexSearcher.<init> Opening Searcher@38664a main
[junit4] 2> 3394523 T10070 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 3394533 T10070 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3394577 T10071 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38664a main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 3394583 T10070 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3394584 T10033 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3394584 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3394593 T10033 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3394597 T10033 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63650
[junit4] 2> 3394598 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3394599 T10033 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3394599 T10033 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 3394599 T10033 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 3394635 T10033 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\solr.xml
[junit4] 2> 3394707 T10033 oasc.CoreContainer.<init> New CoreContainer 25969257
[junit4] 2> 3394707 T10033 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3394709 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3394711 T10033 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3394711 T10033 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3394711 T10033 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3394717 T10033 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3394717 T10033 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3394717 T10033 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3394725 T10082 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 3394725 T10082 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 3394731 T10082 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 3394732 T10082 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3394817 T10082 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 3394892 T10082 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3394892 T10082 oass.IndexSchema.readSchema Reading Solr Schema from schema-custom-field.xml
[junit4] 2> 3394899 T10082 oass.IndexSchema.readSchema [collection1] Schema name=test-custom-field-sort
[junit4] 2> 3394936 T10082 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3394939 T10082 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3394940 T10082 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 3394941 T10082 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard2/data\
[junit4] 2> 3394941 T10082 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ec595
[junit4] 2> 3394941 T10082 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard2/data\
[junit4] 2> 3394941 T10082 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard2/data\index/
[junit4] 2> 3394941 T10082 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '.\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652\shard2\data\index' doesn't exist. Creating new index...
[junit4] 2> 3394942 T10082 oasc.CachingDirectoryFactory.get return new directory for .\org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest-1385739074652/shard2/data\index
[junit4] 2> 3394943 T10082 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 3394944 T10082 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aef76e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c51116)),segFN=segments_1,generation=1}
[junit4] 2> 3394944 T10082 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394944 T10082 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 3394947 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3394948 T10082 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3394948 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394948 T10082 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 3394948 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394949 T10082 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3394949 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394949 T10082 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 3394949 T10082 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 3394950 T10082 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 3394950 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3394951 T10082 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394952 T10082 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3394952 T10082 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3394952 T10082 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3394952 T10082 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3394953 T10082 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3394953 T10082 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3394954 T10082 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 3394954 T10082 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 3394955 T10082 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3394955 T10082 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3394956 T10082 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 3394956 T10082 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 3394956 T10082 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 3394957 T10082 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3394957 T10082 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394958 T10082 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394958 T10082 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394959 T10082 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394959 T10082 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394960 T10082 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394960 T10082 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394961 T10082 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 3394961 T10082 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 3394962 T10082 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 3394968 T10082 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3394971 T10082 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 3394976 T10082 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3394976 T10082 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3394977 T10082 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=50.6640625, floorSegmentMB=1.0888671875, forceMergeDeletesPctAllowed=28.390352486479202, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7906407559386093
[junit4] 2> 3394978 T10082 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aef76e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c51116)),segFN=segments_1,generation=1}
[junit4] 2> 3394978 T10082 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3394978 T10082 oass.SolrIndexSearcher.<init> Opening Searcher@fbad6a main
[junit4] 2> 3394979 T10082 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 3394987 T10082 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3395039 T10083 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@fbad6a main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 3395043 T10082 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 3395045 T10033 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3395045 T10033 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C2593 name=collection1 org.apache.solr.core.SolrCore@bfecd7
[junit4] 2> 3395063 T10042 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1453052737804566528)} 0 2
[junit4] 2> ASYNC NEW_CORE C2594 name=collection1 org.apache.solr.core.SolrCore@15e6224
[junit4] 2> 3395075 T10054 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1453052737817149440)} 0 2
[junit4] 2> ASYNC NEW_CORE C2595 name=collection1 org.apache.solr.core.SolrCore@b4f0f4
[junit4] 2> 3395088 T10065 C2595 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1453052737831829504)} 0 2
[junit4] 2> ASYNC NEW_CORE C2596 name=collection1 org.apache.solr.core.SolrCore@1dbe1f6
[junit4] 2> 3395100 T10077 C2596 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1453052737843363840)} 0 2
[junit4] 2> 3395104 T10043 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[1 (1453052737848606720)]} 0 1
[junit4] 2> 3395107 T10055 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[1 (1453052737852801024)]} 0 0
[junit4] 2> 3395109 T10044 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[2 (1453052737854898176)]} 0 0
[junit4] 2> 3395113 T10066 C2595 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[2 (1453052737858043904)]} 0 1
[junit4] 2> 3395114 T10045 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[3 (1453052737860141056)]} 0 0
[junit4] 2> 3395118 T10078 C2596 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[3 (1453052737864335360)]} 0 0
[junit4] 2> 3395122 T10040 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[4 (1453052737868529664)]} 0 0
[junit4] 2> 3395125 T10056 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[4 (1453052737871675392)]} 0 0
[junit4] 2> 3395127 T10042 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[5 (1453052737873772544)]} 0 0
[junit4] 2> 3395131 T10067 C2595 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[5 (1453052737877966848)]} 0 0
[junit4] 2> 3395134 T10043 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[6 (1453052737881112576)]} 0 0
[junit4] 2> 3395136 T10079 C2596 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[6 (1453052737883209728)]} 0 0
[junit4] 2> 3395140 T10044 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[7 (1453052737887404032)]} 0 0
[junit4] 2> 3395142 T10057 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[7 (1453052737889501184)]} 0 0
[junit4] 2> 3395145 T10045 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[8 (1453052737892646912)]} 0 0
[junit4] 2> 3395147 T10068 C2595 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[8 (1453052737894744064)]} 0 0
[junit4] 2> 3395151 T10041 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[9 (1453052737898938368)]} 0 0
[junit4] 2> 3395154 T10080 C2596 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[9 (1453052737902084096)]} 0 0
[junit4] 2> 3395157 T10040 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[10 (1453052737905229824)]} 0 0
[junit4] 2> 3395160 T10052 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[10 (1453052737908375552)]} 0 0
[junit4] 2> 3395163 T10042 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[11 (1453052737911521280)]} 0 0
[junit4] 2> 3395166 T10069 C2595 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[11 (1453052737914667008)]} 0 0
[junit4] 2> 3395169 T10043 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[12 (1453052737917812736)]} 0 0
[junit4] 2> 3395172 T10081 C2596 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[12 (1453052737920958464)]} 0 0
[junit4] 2> 3395175 T10044 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[13 (1453052737924104192)]} 0 0
[junit4] 2> 3395179 T10053 C2594 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={version=2&wt=javabin} {add=[13 (1453052737928298496)]} 0 0
[junit4] 2> 3395181 T10045 C2593 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 3395187 T10045 C2593 oasup.LogUpdateProcessor.finish [collection1] webapp=/nqu/k path=/update params={waitSearcher=true&version=2&commit=true&softCommit=false&wt=javabin} {} 0 6
[junit4] 2> 3395187 T10045 C2593 oasc.SolrException.log ERROR java.lang.UnsupportedOperationException: this codec cannot write docvalues
[junit4] 2> at org.apache.lucene.codecs.lucene3x.Lucene3xCodec$1.fieldsConsumer(Lucene3xCodec.java:73)
[junit4] 2> at org.apache.lucene.index.DocValuesProcessor.flush(DocValuesProcessor.java:77)
[junit4] 2> at org.apache.lucene.index.TwoStoredFieldsConsumers.flush(TwoStoredFieldsConsumers.java:42)
[junit4] 2> at org.apache.lucene.index.DocFieldProcessor.flush(DocFieldProcessor.java:80)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:465)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:506)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:616)
[junit4] 2> at org.apache.lucene.index.IndexWriter.prepareCommitInternal(IndexWriter.java:2815)
[junit4] 2> at org.apache.lucene.index.IndexWriter.commitInternal(IndexWriter.java:2970)
[junit4] 2> at org.apache.lucene.index.IndexWriter.commit(IndexWriter.java:2940)
[junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:559)
[junit4] 2> at org.apache.solr.update.processor.RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:95)
[junit4] 2> at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:64)
[junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1444)
[junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1421)
[junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:157)
[junit4] 2> at org.apache.solr.handler.RequestHandlerUtils.handleCommit(RequestHandlerUtils.java:69)
[junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1872)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:753)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:200)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:134)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:953)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1014)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:240)
[junit4] 2> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 3395188 T10045 C2593 oasc.SolrException.log ERROR null:java.lang.UnsupportedOperationException: this codec cannot write docvalues
[junit4] 2> at org.apache.lucene.codecs.lucene3x.Lucene3xCodec$1.fieldsConsumer(Lucene3xCodec.java:73)
[junit4] 2> at org.apache.lucene.index.DocValuesProcessor.flush(DocValuesProcessor.java:77)
[junit4] 2> at org.apache.lucene.index.TwoStoredFieldsConsumers.flush(TwoStoredFieldsConsumers.java:42)
[junit4] 2> at org.apache.lucene.index.DocFieldProcessor.flush(DocFieldProcessor.java:80)
[junit4] 2> at org.apache.lucene.index.DocumentsWriterPerThread.flush(DocumentsWriterPerThread.java:465)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:506)
[junit4] 2> at org.apache.lucene.index.DocumentsWriter.flushAllThreads(DocumentsWriter.java:616)
[junit4] 2> at org.apache.lucene.index.IndexWriter.prepareCommitInternal(IndexWriter.java:2815)
[junit4] 2> at org.apache.lucene.index.IndexWriter.commitInternal(IndexWriter.java:2970)
[junit4] 2> at org.apache.lucene.index.IndexWriter.commit(IndexWriter.java:2940)
[junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:559)
[junit4] 2> at org.apache.solr.update.processor.RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:95)
[junit4] 2> at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:64)
[junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1444)
[junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1421)
[junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:157)
[junit4] 2> at org.apache.solr.handler.RequestHandlerUtils.handleCommit(RequestHandlerUtils.java:69)
[junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1872)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:753)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:200)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:134)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.jav
[...truncated too long message...]
ex;done=false>>]
[junit4] 2> 3395712 T10033 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\index
[junit4] 2> 3395712 T10033 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\;done=false>>]
[junit4] 2> 3395712 T10033 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-DistributedQueryComponentCustomSortTest-1385739074020\
[junit4] 2> NOTE: test params are: codec=Lucene3x, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=nl, timezone=Pacific/Enderbury
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_45 (32-bit)/cpus=2,threads=1,free=212129144,total=397934592
[junit4] 2> NOTE: All tests run in this JVM: [TestDistributedGrouping, NoCacheHeaderTest, TestDefaultSearchFieldResource, TestWordDelimiterFilterFactory, SignatureUpdateProcessorFactoryTest, SuggesterTest, HdfsDirectoryTest, DocumentBuilderTest, TestGroupingSearch, TestSolrQueryParser, AliasIntegrationTest, UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest, TestFuzzyAnalyzedSuggestions, TestJoin, OverseerCollectionProcessorTest, FileUtilsTest, TestUniqueKeyFieldResource, CoreAdminHandlerTest, FieldMutatingUpdateProcessorTest, SampleTest, TestShardHandlerFactory, HdfsCollectionsAPIDistributedZkTest, LegacyHTMLStripCharFilterTest, SpellCheckCollatorTest, TestCSVLoader, TestDocSet, ModifyConfFileTest, ZkControllerTest, SliceStateTest, MigrateRouteKeyTest, TestDocBasedVersionConstraints, DirectUpdateHandlerOptimizeTest, TestDynamicFieldCollectionResource, TestIndexSearcher, TestSchemaVersionResource, PreAnalyzedFieldTest, TestExtendedDismaxParser, SortByFunctionTest, SolrIndexSplitterTest, DistributedDebugComponentTest, CollectionsAPIDistributedZkTest, BasicDistributedZk2Test, TestFunctionQuery, PrimitiveFieldTypeTest, FastVectorHighlighterTest, TestRealTimeGet, JSONWriterTest, TestFastOutputStream, CacheHeaderTest, TestStressReorder, BasicDistributedZkTest, TestIBSimilarityFactory, ZkSolrClientTest, CSVRequestHandlerTest, TestNonNRTOpen, UUIDFieldTest, TestMaxScoreQueryParser, TestSolrQueryParserResource, TestStressUserVersions, AlternateDirectoryTest, TestAnalyzedSuggestions, TestFieldTypeCollectionResource, LeaderElectionIntegrationTest, TestSchemaResource, SystemInfoHandlerTest, TestAnalyzeInfixSuggestions, DocValuesMultiTest, SuggesterWFSTTest, DefaultValueUpdateProcessorTest, DistributedSuggesterComponentTest, TestCustomSort, TestTrie, TestCSVResponseWriter, TestSolrCoreProperties, RecoveryZkTest, EnumFieldTest, SolrInfoMBeanTest, OpenExchangeRatesOrgProviderTest, CopyFieldTest, TestSweetSpotSimilarityFactory, MBeansHandlerTest, TestSurroundQueryParser, FieldAnalysisRequestHandlerTest, TestHashPartitioner, SpellingQueryConverterTest, TestRandomFaceting, TriLevelCompositeIdRoutingTest, TestCollationKeyRangeQueries, TestSearchPerf, SpatialFilterTest, TestCharFilters, AnalysisAfterCoreReloadTest, SliceStateUpdateTest, BJQParserTest, ShardRoutingCustomTest, ChaosMonkeyNothingIsSafeTest, SpellPossibilityIteratorTest, TestFieldTypeResource, ClusterStateTest, BlockDirectoryTest, TestSolrDeletionPolicy1, TestNumberUtils, TestSerializedLuceneMatchVersion, AssignTest, DocValuesMissingTest, SolrCmdDistributorTest, SynonymTokenizerTest, TestSolrXmlPersistence, TermVectorComponentDistributedTest, ChangedSchemaMergeTest, TestDocumentBuilder, DebugComponentTest, ResponseLogComponentTest, PeerSyncTest, TestReversedWildcardFilterFactory, TestConfig, TestCloudManagedSchemaAddField, TestOmitPositions, HdfsBasicDistributedZkTest, TestRemoteStreaming, TestSolrXml, ConvertedLegacyTest, DateMathParserTest, UnloadDistributedZkTest, TestLFUCache, SolrTestCaseJ4Test, TestCopyFieldCollectionResource, DocValuesTest, SimplePostToolTest, InfoHandlerTest, TestAddFieldRealTimeGet, TestStressLucene, TestMergePolicyConfig, CachingDirectoryFactoryTest, ZkNodePropsTest, HdfsBasicDistributedZk2Test, DateFieldTest, TestNRTOpen, TestRandomMergePolicy, ParsingFieldUpdateProcessorsTest, WordBreakSolrSpellCheckerTest, ExternalFileFieldSortTest, TestFiltering, QueryEqualityTest, TestPHPSerializedResponseWriter, TestAtomicUpdateErrorCases, JsonLoaderTest, SoftAutoCommitTest, BadCopyFieldTest, TestManagedSchemaFieldResource, SchemaVersionSpecificBehaviorTest, TestStressRecovery, TestWriterPerf, TestQueryUtils, TestCoreContainer, TestLuceneMatchVersion, CustomCollectionTest, TestSchemaSimilarityResource, TestFieldCollectionResource, TestPostingsSolrHighlighter, SuggesterFSTTest, TestArbitraryIndexDir, RequiredFieldsTest, TestSort, TestMultiCoreConfBootstrap, DirectSolrSpellCheckerTest, TestHighFrequencyDictionaryFactory, ChaosMonkeySafeLeaderTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, ShardRoutingTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, ClusterStateUpdateTest, LeaderElectionTest, TestZkChroot, TestRandomDVFaceting, ZkCLITest, TestDistributedSearch, AutoCommitTest, TestFaceting, TestRecovery, DistributedSpellCheckComponentTest, TestReload, TestStressVersions, HardAutoCommitTest, DistributedTermsComponentTest, TestRangeQuery, SimpleFacetsTest, TestSolr4Spatial, SolrCoreTest, StatsComponentTest, SpellCheckComponentTest, QueryElevationComponentTest, BadIndexSchemaTest, BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest, TestBadConfig, HighlighterTest, ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, TestCoreDiscovery, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, PolyFieldTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, StatelessScriptUpdateProcessorFactoryTest, DistanceFunctionTest, XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, DisMaxRequestHandlerTest, StandardRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestQueryTypes, FileBasedSpellCheckerTest, TermsComponentTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest, SolrPluginUtilsTest, IndexSchemaTest, TestJmxIntegration, TestCollationField, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, QueryParsingTest, TestPartialUpdateDeduplication, PingRequestHandlerTest, TestComponentsName, SearchHandlerTest, CoreContainerCoreInitFailuresTest, TestBinaryResponseWriter, HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, TestSolrIndexConfig, TestQuerySenderNoQuery, SolrIndexConfigTest, BadComponentTest, TestSolrDeletionPolicy2, MultiTermTest, TestBinaryField, NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery, OutputWriterTest, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestPhraseSuggestions, TestCodecSupport, TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TestDefaultSimilarityFactory, TestFastWriter, TestJmxMonitoredMap, TimeZoneUtilsTest, ResourceLoaderTest, ScriptEngineTest, URLClassifyProcessorTest, PluginInfoTest, TestFastLRUCache, TestSolrXMLSerializer, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ, TestLRUCache, TestUtils, CircularListTest, TestRTGBase, TestDistributedMissingSort, DeleteInactiveReplicaTest, DeleteReplicaTest, DeleteShardTest, ShardSplitTest, SolrXmlInZkTest, TestDistribDocBasedVersion, TestModifyConfFiles, HdfsChaosMonkeySafeLeaderTest, HdfsRecoveryZkTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest, StressHdfsTest, QueryResultKeyTest, TestImplicitCoreProperties, TestInfoStreamLogging, TestReloadAndDeleteDocs, TestSolrXmlPersistor, CoreAdminCreateDiscoverTest, CoreMergeIndexesAdminHandlerTest, DistributedQueryComponentCustomSortTest]
[junit4] Completed in 3.11s, 1 test, 1 error <<< FAILURES!
[...truncated 66 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:426: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:406: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1279: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:912: There were test failures: 349 suites, 1516 tests, 1 error, 39 ignored (11 assumptions)
Total time: 86 minutes 40 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_45 -server -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure