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 2016/02/09 15:43:35 UTC

[JENKINS] Lucene-Solr-5.x-Windows (32bit/jdk1.8.0_72) - Build # 5476 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/5476/
Java: 32bit/jdk1.8.0_72 -server -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.handler.dataimport.TestContentStreamDataSource.testCommitWithin

Error Message:
expected:<0> but was:<2>

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




Build Log:
[...truncated 16212 lines...]
   [junit4] Suite: org.apache.solr.handler.dataimport.TestContentStreamDataSource
   [junit4]   2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\init-core-data-001
   [junit4]   2> 24627 T69 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 24630 T69 oas.SolrTestCaseJ4.setUp ###Starting testSimple
   [junit4]   2> 25060 T69 oejs.Server.doStart jetty-9.2.13.v20150730
   [junit4]   2> 25201 T69 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@c441dc{/solr,null,AVAILABLE}
   [junit4]   2> 25367 T69 oejs.AbstractConnector.doStart Started ServerConnector@916841{SSL-http/1.1}{127.0.0.1:51824}
   [junit4]   2> 25367 T69 oejs.Server.doStart Started @27556ms
   [junit4]   2> 25367 T69 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=51824}
   [junit4]   2> 25381 T69 oass.SolrDispatchFilter.init SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 25386 T69 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001'
   [junit4]   2> 25386 T69 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 25386 T69 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\dih-properties-001
   [junit4]   2> 25391 T69 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\solr.xml
   [junit4]   2> 25420 T69 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001
   [junit4]   2> 25421 T69 oasc.CoreContainer.<init> New CoreContainer 11191163
   [junit4]   2> 25421 T69 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001]
   [junit4]   2> 25421 T69 oasc.CoreContainer.load WARN Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\lib
   [junit4]   2> 25466 T69 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,urlScheme : https,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 25475 T69 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 25479 T69 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 25479 T69 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 25479 T69 oasc.CoreContainer.initializeAuthorizationPlugin Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 25479 T69 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
   [junit4]   2> 25481 T69 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001
   [junit4]   2> 25487 T69 oasc.CoreDescriptor.<init> Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
   [junit4]   2> 25487 T69 oasc.CorePropertiesLocator$1.visitFile Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1
   [junit4]   2> 25488 T69 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 25488 T82 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1'
   [junit4]   2> 25489 T82 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 25490 T82 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\dih-properties-001
   [junit4]   2> 25493 T69 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0
   [junit4]   2> 25493 T69 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 25509 T82 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 25511 T82 oasc.Config.assertWarnOrFail WARN Beginning with Solr 5.5, <maxMergeDocs> is deprecated, configure it on the relevant <mergePolicyFactory> instead.
   [junit4]   2> 25511 T82 oasc.Config.assertWarnOrFail WARN Beginning with Solr 5.5, <mergeFactor> is deprecated, configure it on the relevant <mergePolicyFactory> instead.
   [junit4]   2> 25512 T82 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 25523 T82 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 25533 T82 oass.IndexSchema.readSchema [collection1] Schema name=dih_test
   [junit4]   2> 25549 T82 oass.IndexSchema.readSchema default search field in schema is desc
   [junit4]   2> 25549 T82 oass.IndexSchema.readSchema query parser default operator is OR
   [junit4]   2> 25549 T82 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 25555 T82 oasc.ConfigSetProperties.readFromResourceLoader Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1'
   [junit4]   2> 25555 T82 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1
   [junit4]   2> 25556 T82 x:x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 25556 T82 x:x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\]
   [junit4]   2> 25556 T82 x:x:collection1 oasc.SolrCore.initInfoRegistry JMX monitoring not detected for core: collection1
   [junit4]   2> 25556 T82 x:x:collection1 oasc.SolrCore.initListeners [[collection1] ] Added SolrEventListener for newSearcher: [org.apache.solr.core.QuerySenderListener{queries=[{q=solr,start=0,rows=10}, {q=rocks,start=0,rows=10}, {q=static newSearcher warming query from solrconfig.xml}]}]
   [junit4]   2> 25556 T82 x:x:collection1 oasc.SolrCore.initListeners [[collection1] ] Added SolrEventListener for firstSearcher: [org.apache.solr.core.QuerySenderListener{queries=[]}]
   [junit4]   2> 25557 T82 x:x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\
   [junit4]   2> 25557 T82 x:x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index/
   [junit4]   2> 25557 T82 x:x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 25557 T82 x:x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index
   [junit4]   2> 25558 T82 x:x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@18ad61f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b85d3),segFN=segments_1,generation=1}
   [junit4]   2> 25558 T82 x:x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 25559 T86 x:x:collection1 oasc.SolrCore$12.run Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\
   [junit4]   2> 25559 T82 x:x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "" (default)
   [junit4]   2> 25560 T82 x:x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
   [junit4]   2> 25567 T82 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 25568 T82 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 25569 T82 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 25571 T82 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 25574 T82 x:x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,,/update/csv,/search,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file,/dataimport
   [junit4]   2> 25574 T82 x:x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 25575 T82 x:x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 25575 T82 x:x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 25576 T82 x:x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@18ad61f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b85d3),segFN=segments_1,generation=1}
   [junit4]   2> 25576 T82 x:x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 25576 T82 x:x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@16b4602[collection1] main
   [junit4]   2> 25576 T82 x:x:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\conf
   [junit4]   2> 25576 T82 x:x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\conf}
   [junit4]   2> 25577 T82 x:x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\conf
   [junit4]   2> 25577 T82 x:x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 25577 T82 x:x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 25577 T87 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@16b4602[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 25578 T82 x:x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 25578 T87 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 25578 T87 x:x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16b4602[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C12 name=collection1 org.apache.solr.core.SolrCore@1e9eaa5
   [junit4]   2> 26912 T79 x:x:collection1 C12 oashd.DataImporter.maybeReloadConfiguration Loading DIH Configuration: data-config.xml
   [junit4]   2> 26914 T79 x:x:collection1 C12 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
   [junit4]   2> 26915 T79 x:x:collection1 C12 oashd.DataImporter.doFullImport Starting Full Import
   [junit4]   2> 26915 T79 x:x:collection1 C12 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
   [junit4]   2> 27017 T79 x:x:collection1 C12 oashd.DocBuilder.finish Import completed successfully
   [junit4]   2> 27018 T79 x:x:collection1 C12 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 27021 T79 x:x:collection1 C12 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@18ad61f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b85d3),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@18ad61f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b85d3),segFN=segments_2,generation=2}
   [junit4]   2> 27022 T79 x:x:collection1 C12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 27025 T79 x:x:collection1 C12 oass.SolrIndexSearcher.<init> Opening Searcher@1b5179f[collection1] main
   [junit4]   2> 27025 T79 x:x:collection1 C12 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 27025 T87 x:x:collection1 C12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1b5179f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C2)))}
   [junit4]   2> 27026 T87 x:x:collection1 C12 oasr.SolrRequestInfo.setRequestInfo ERROR Previous SolrRequestInfo was not closed!  req=clean=false&wt=javabin&version=2&command=full-import
   [junit4]   2> 27026 T87 x:x:collection1 C12 oasr.SolrRequestInfo.setRequestInfo ERROR prev == info : false
   [junit4]   2> 27026 T87 x:x:collection1 oasc.SolrException.log ERROR null:java.lang.AssertionError
   [junit4]   2> 		at org.apache.solr.request.SolrRequestInfo.setRequestInfo(SolrRequestInfo.java:61)
   [junit4]   2> 		at org.apache.solr.core.QuerySenderListener.newSearcher(QuerySenderListener.java:67)
   [junit4]   2> 		at org.apache.solr.core.SolrCore$6.call(SolrCore.java:1868)
   [junit4]   2> 		at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 		at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 		at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 		at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 		at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 	
   [junit4]   2> 27026 T87 x:x:collection1 C12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b5179f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C2)))}
   [junit4]   2> 27027 T79 x:x:collection1 C12 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
   [junit4]   2> 30866 T79 x:x:collection1 C12 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
   [junit4]   2> 30866 T79 x:x:collection1 C12 oashd.DocBuilder.execute Time taken = 0:0:3.957
   [junit4]   2> 30866 T79 x:x:collection1 C12 oasup.LogUpdateProcessorFactory$LogUpdateProcessor.finish [collection1]  webapp=/solr path=/dataimport params={clean=false&wt=javabin&version=2&command=full-import}{add=[1, 2],commit=} 0 3996
   [junit4]   2> 30971 T74 x:x:collection1 C12 oasc.SolrCore.execute [collection1]  webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 30993 T69 oejs.AbstractConnector.doStop Stopped ServerConnector@916841{SSL-http/1.1}{127.0.0.1:0}
   [junit4]   2> 30993 T69 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11191163
   [junit4]   2> 30995 T90 x:x:collection1 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1e9eaa5
   [junit4]   2> 30995 T90 x:x:collection1 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=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 30996 T90 x:x:collection1 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 30996 T90 x:x:collection1 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 30996 T90 x:x:collection1 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 30998 T90 x:x:collection1 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 30998 T90 x:x:collection1 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 30998 T90 x:x:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index;done=false>>]
   [junit4]   2> 30998 T90 x:x:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\index
   [junit4]   2> 30998 T90 x:x:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\;done=false>>]
   [junit4]   2> 30998 T90 x:x:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-001\collection1\data\
   [junit4]   2> 31003 T69 oejsh.ContextHandler.doStop Stopped o.e.j.s.ServletContextHandler@c441dc{/solr,null,UNAVAILABLE}
   [junit4]   2> 31013 T69 oas.SolrTestCaseJ4.tearDown ###Ending testSimple
   [junit4]   2> 31016 T69 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithin
   [junit4]   2> 31032 T69 oejs.Server.doStart jetty-9.2.13.v20150730
   [junit4]   2> 31036 T69 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@1473b20{/solr,null,AVAILABLE}
   [junit4]   2> 31046 T69 oejs.AbstractConnector.doStart Started ServerConnector@f36bc4{SSL-http/1.1}{127.0.0.1:51830}
   [junit4]   2> 31046 T69 oejs.Server.doStart Started @33246ms
   [junit4]   2> 31046 T69 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=51830}
   [junit4]   2> 31047 T69 oass.SolrDispatchFilter.init SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 31047 T69 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002'
   [junit4]   2> 31047 T69 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 31048 T69 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\dih-properties-002
   [junit4]   2> 31049 T69 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\solr.xml
   [junit4]   2> 31060 T69 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002
   [junit4]   2> 31060 T69 oasc.CoreContainer.<init> New CoreContainer 13648255
   [junit4]   2> 31060 T69 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002]
   [junit4]   2> 31060 T69 oasc.CoreContainer.load WARN Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\lib
   [junit4]   2> 31060 T69 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,urlScheme : https,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 31066 T69 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 31068 T69 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 31068 T69 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 31068 T69 oasc.CoreContainer.initializeAuthorizationPlugin Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 31069 T69 oasc.CoreContainer.initializeAuthenticationPlugin No authentication plugin used.
   [junit4]   2> 31070 T69 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002
   [junit4]   2> 31072 T69 oasc.CoreDescriptor.<init> Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
   [junit4]   2> 31072 T69 oasc.CorePropertiesLocator$1.visitFile Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1
   [junit4]   2> 31073 T69 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 31074 T102 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1'
   [junit4]   2> 31074 T69 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0
   [junit4]   2> 31075 T69 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 31075 T102 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 31075 T102 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\dih-properties-002
   [junit4]   2> 31096 T102 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 31101 T102 oasc.Config.assertWarnOrFail WARN Beginning with Solr 5.5, <maxMergeDocs> is deprecated, configure it on the relevant <mergePolicyFactory> instead.
   [junit4]   2> 31101 T102 oasc.Config.assertWarnOrFail WARN Beginning with Solr 5.5, <mergeFactor> is deprecated, configure it on the relevant <mergePolicyFactory> instead.
   [junit4]   2> 31104 T102 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 31110 T102 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 31119 T102 oass.IndexSchema.readSchema [collection1] Schema name=dih_test
   [junit4]   2> 31127 T102 oass.IndexSchema.readSchema default search field in schema is desc
   [junit4]   2> 31127 T102 oass.IndexSchema.readSchema query parser default operator is OR
   [junit4]   2> 31127 T102 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 31133 T102 oasc.ConfigSetProperties.readFromResourceLoader Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1'
   [junit4]   2> 31133 T102 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1
   [junit4]   2> 31133 T102 x:x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 31133 T102 x:x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\]
   [junit4]   2> 31133 T102 x:x:collection1 oasc.SolrCore.initInfoRegistry JMX monitoring not detected for core: collection1
   [junit4]   2> 31134 T102 x:x:collection1 oasc.SolrCore.initListeners [[collection1] ] Added SolrEventListener for newSearcher: [org.apache.solr.core.QuerySenderListener{queries=[{q=solr,start=0,rows=10}, {q=rocks,start=0,rows=10}, {q=static newSearcher warming query from solrconfig.xml}]}]
   [junit4]   2> 31134 T102 x:x:collection1 oasc.SolrCore.initListeners [[collection1] ] Added SolrEventListener for firstSearcher: [org.apache.solr.core.QuerySenderListener{queries=[]}]
   [junit4]   2> 31134 T102 x:x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\
   [junit4]   2> 31137 T102 x:x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index/
   [junit4]   2> 31137 T102 x:x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 31138 T102 x:x:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index
   [junit4]   2> 31138 T102 x:x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1f278cd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e720b7),segFN=segments_1,generation=1}
   [junit4]   2> 31138 T102 x:x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 31140 T102 x:x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "" (default)
   [junit4]   2> 31140 T102 x:x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
   [junit4]   2> 31144 T106 x:x:collection1 oasc.SolrCore$12.run Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\
   [junit4]   2> 31145 T102 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 31147 T102 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 31148 T102 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 31150 T102 x:x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 31152 T102 x:x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,,/update/csv,/search,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file,/dataimport
   [junit4]   2> 31152 T102 x:x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 31153 T102 x:x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 31153 T102 x:x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 31153 T102 x:x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1f278cd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e720b7),segFN=segments_1,generation=1}
   [junit4]   2> 31153 T102 x:x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 31154 T102 x:x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@86a1b2[collection1] main
   [junit4]   2> 31154 T102 x:x:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\conf
   [junit4]   2> 31154 T102 x:x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\conf}
   [junit4]   2> 31155 T102 x:x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\conf
   [junit4]   2> 31155 T102 x:x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 31155 T102 x:x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 31156 T107 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@86a1b2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 31156 T102 x:x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 31156 T107 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 31156 T107 x:x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@86a1b2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C13 name=collection1 org.apache.solr.core.SolrCore@c49480
   [junit4]   2> 31622 T96 x:x:collection1 C13 oashd.DataImporter.maybeReloadConfiguration Loading DIH Configuration: data-config.xml
   [junit4]   2> 31624 T96 x:x:collection1 C13 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
   [junit4]   2> 31624 T96 x:x:collection1 C13 oashd.DataImporter.doFullImport Starting Full Import
   [junit4]   2> 31625 T96 x:x:collection1 C13 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
   [junit4]   2> 31628 T96 x:x:collection1 C13 oashd.DocBuilder.finish Import completed successfully
   [junit4]   2> 31629 T96 x:x:collection1 C13 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
   [junit4]   2> 32629 T110 x:x:collection1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 32634 T110 x:x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@161f5af[collection1] main
   [junit4]   2> 32635 T110 x:x:collection1 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 32635 T107 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@161f5af[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C2)))}
   [junit4]   2> 32636 T107 x:x:collection1 C13 oasc.SolrCore.execute [collection1]  webapp=null path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} hits=0 status=0 QTime=0
   [junit4]   2> 32636 T107 x:x:collection1 C13 oasc.SolrCore.execute [collection1]  webapp=null path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} hits=0 status=0 QTime=0
   [junit4]   2> 32636 T107 x:x:collection1 C13 oasc.SolrCore.execute [collection1]  webapp=null path=null params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher} hits=0 status=0 QTime=0
   [junit4]   2> 32637 T107 x:x:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
   [junit4]   2> 32637 T107 x:x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@161f5af[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C2)))}
   [junit4]   2> 36010 T96 x:x:collection1 C13 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
   [junit4]   2> 36010 T96 x:x:collection1 C13 oashd.DocBuilder.execute Time taken = 0:0:4.386
   [junit4]   2> 36010 T96 x:x:collection1 C13 oasup.LogUpdateProcessorFactory$LogUpdateProcessor.finish [collection1]  webapp=/solr path=/dataimport params={commitWithin=1000&commit=false&clean=false&wt=javabin&version=2&command=full-import}{add=[1, 2]} 0 4389
   [junit4]   2> 36117 T94 x:x:collection1 C13 oasc.SolrCore.execute [collection1]  webapp=/solr path=/select params={q=*&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 36131 T69 oejs.AbstractConnector.doStop Stopped ServerConnector@f36bc4{SSL-http/1.1}{127.0.0.1:0}
   [junit4]   2> 36131 T69 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=13648255
   [junit4]   2> 36132 T112 x:x:collection1 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@c49480
   [junit4]   2> 36133 T112 x:x:collection1 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 36133 T112 x:x:collection1 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 36133 T112 x:x:collection1 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 36133 T112 x:x:collection1 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 36135 T112 x:x:collection1 C13 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1f278cd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e720b7),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1f278cd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e720b7),segFN=segments_2,generation=2}
   [junit4]   2> 36135 T112 x:x:collection1 C13 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 36138 T112 x:x:collection1 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 36138 T112 x:x:collection1 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 36138 T112 x:x:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index;done=false>>]
   [junit4]   2> 36138 T112 x:x:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\index
   [junit4]   2> 36138 T112 x:x:collection1 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\;done=false>>]
   [junit4]   2> 36138 T112 x:x:collection1 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001\inst-002\collection1\data\
   [junit4]   2> 36141 T69 oejsh.ContextHandler.doStop Stopped o.e.j.s.ServletContextHandler@1473b20{/solr,null,UNAVAILABLE}
   [junit4]   2> 36160 T69 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithin
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestContentStreamDataSource -Dtests.method=testCommitWithin -Dtests.seed=60809F1579237ABB -Dtests.slow=true -Dtests.locale=ru -Dtests.timezone=Asia/Amman -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 5.16s J0 | TestContentStreamDataSource.testCommitWithin <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<0> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([60809F1579237ABB:DA52F06DFA0D94AE]:0)
   [junit4]    > 	at org.apache.solr.handler.dataimport.TestContentStreamDataSource.testCommitWithin(TestContentStreamDataSource.java:97)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 36172 T69 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestContentStreamDataSource_60809F1579237ABB-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {id=Lucene50(blocksize=128), desc=PostingsFormat(name=LuceneFixedGap), timestamp=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{}, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=ru, timezone=Asia/Amman
   [junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_72 (32-bit)/cpus=3,threads=1,free=23449592,total=64880640
   [junit4]   2> NOTE: All tests run in this JVM: [TestZKPropertiesWriter, TestWriterImpl, TestSqlEntityProcessor, TestContentStreamDataSource]
   [junit4] Completed [21/38 (1!)] on J0 in 11.57s, 2 tests, 1 failure <<< FAILURES!

[...truncated 61 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:750: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:694: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:253: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:469: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:534: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1477: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1033: There were test failures: 38 suites, 157 tests, 1 failure, 3 ignored [seed: 60809F1579237ABB]

Total time: 80 minutes 22 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any