Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11000/
Java: 64bit/jdk1.7.0_65 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC

4 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSimplePropertiesWriter

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSimplePropertiesWriter:     1) 
Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]         at java.lang.Object.wait(Native 
Method)         at java.lang.Object.wait(Object.java:503)         at 
java.util.TimerThread.mainLoop(Timer.java:526)         at 
java.util.TimerThread.run(Timer.java:505)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.dataimport.TestSimplePropertiesWriter: 
   1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:503)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSimplePropertiesWriter

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=17, 
name=Timer-0, state=WAITING, group=TGRP-TestSimplePropertiesWriter]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:503)         at 
java.util.TimerThread.mainLoop(Timer.java:526)         at 
java.util.TimerThread.run(Timer.java:505)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:503)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta:     1) 
Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]         at java.lang.Object.wait(Native 
Method)         at java.lang.Object.wait(Object.java:503)         at 
java.util.TimerThread.mainLoop(Timer.java:526)         at 
java.util.TimerThread.run(Timer.java:505)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta: 
   1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:503)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=37, 
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessorDelta]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:503)         at 
java.util.TimerThread.mainLoop(Timer.java:526)         at 
java.util.TimerThread.run(Timer.java:505)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:503)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)




Build Log:
[...truncated 14985 lines...]
   [junit4] Suite: org.apache.solr.handler.dataimport.TestSimplePropertiesWriter
   [junit4]   2> Creating dataDir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 1446 T16 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (true)
   [junit4]   2> 2315 T16 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 2369 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader 
for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/'
   [junit4]   2> 2742 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 2932 T16 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 2941 T16 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 2964 T16 oass.IndexSchema.readSchema [null] Schema 
name=dih_test
   [junit4]   2> 3129 T16 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 3130 T16 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 3132 T16 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3139 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 3139 T16 oasc.SolrResourceLoader.locateSolrHome using system 
property solr.solr.home: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001
   [junit4]   2> 3140 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader 
for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/'
   [junit4]   2> 3242 T16 oasc.CoreContainer.<init> New CoreContainer 697396101
   [junit4]   2> 3244 T16 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/]
   [junit4]   2> 3265 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 0
   [junit4]   2> 3266 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 3266 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 0
   [junit4]   2> 3267 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 3267 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 3268 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 3268 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 3269 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 3269 T16 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 3525 T16 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 3532 T16 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3534 T16 oasl.LogWatcher.newRegisteredLogWatcher Registering 
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3536 T16 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 3679 T18 oasc.SolrResourceLoader.<init> new SolrResourceLoader 
for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/'
   [junit4]   2> 3768 T18 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 3858 T18 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 3860 T18 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 3900 T18 oass.IndexSchema.readSchema [collection1] Schema 
name=dih_test
   [junit4]   2> 3959 T18 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 3961 T18 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 3964 T18 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3967 T18 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/
   [junit4]   2> 4012 T18 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4026 T18 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/
   [junit4]   2> 4027 T18 oasc.SolrCore.<init> JMX monitoring not detected for 
core: collection1
   [junit4]   2> 4042 T18 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> 4043 T18 oasc.SolrCore.initListeners [collection1] Added 
SolrEventListener for firstSearcher: 
org.apache.solr.core.QuerySenderListener{queries=[]}
   [junit4]   2> 4075 T18 oasc.CachingDirectoryFactory.get return new directory 
for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 4077 T18 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index/
   [junit4]   2> 4078 T18 oasc.SolrCore.initIndex WARN [collection1] Solr index 
directory 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 4079 T18 oasc.CachingDirectoryFactory.get return new directory 
for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index
   [junit4]   2> 4151 T18 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 4153 T18 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 4454 T18 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "" (default)
   [junit4]   2> 4497 T18 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
   [junit4]   2> 4507 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 4508 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 4508 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 4509 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 4520 T18 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 4525 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
   [junit4]   2> 4526 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/search: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 4532 T18 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 4533 T18 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 4586 T18 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4595 T18 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4597 T18 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4600 T18 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4602 T18 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4634 T18 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 4634 T18 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 4639 T18 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 4639 T18 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 4678 T18 oass.SolrIndexSearcher.<init> Opening 
Searcher@39731fbd[collection1] main
   [junit4]   2> 4699 T18 oasr.ManagedResourceStorage$FileStorageIO.configure 
File-based storage initialized to use dir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 4699 T18 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/conf}
   [junit4]   2> 4734 T18 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 4735 T18 oasr.ManagedResource.reloadFromStorage WARN No stored 
data found for /rest/managed
   [junit4]   2> 4742 T18 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using 
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 4743 T18 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4785 T18 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 4786 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@39731fbd[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 4787 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 4788 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@39731fbd[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 4793 T16 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 4804 T16 oas.SolrTestCaseJ4.setUp ###Starting 
testSimplePropertiesWriter
   [junit4]   2> ASYNC  NEW_CORE C0 name=collection1 
org.apache.solr.core.SolrCore@6b6b1935
   [junit4]   2> 4938 T16 C0 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 4943 T16 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 136
   [junit4]   2> 4959 T16 C0 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 4961 T16 C0 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_2,generation=2}
   [junit4]   2> 4962 T16 C0 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 4963 T16 C0 oass.SolrIndexSearcher.<init> Opening 
Searcher@18ec9ac8[collection1] main
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 
org.apache.solr.core.SolrCore@6b6b1935
   [junit4]   2> 4975 T16 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 4977 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@18ec9ac8[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 5005 T19 C1 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=solr&start=0} 
hits=0 status=0 QTime=25 
   [junit4]   2> 5006 T19 C1 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=rocks&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 5019 T19 C1 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={event=newSearcher&distrib=false&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=12 
   [junit4]   2> 5019 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 5020 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@18ec9ac8[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 5020 T16 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 61
   [junit4]   2> 6010 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
WARN Unable to read: the.properties
   [junit4]   2> 6012 T16 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 
org.apache.solr.core.SolrCore@6b6b1935
   [junit4]   2> 6032 T16 C2 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 6032 T16 C2 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 6037 T16 C2 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 6056 T16 C2 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6081 T16 C2 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 6093 T16 C2 oashd.JdbcDataSource$1.call Creating a connection 
for entity SomeDates with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 6095 T16 C2 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> ASYNC  NEW_CORE C3 name=collection1 
org.apache.solr.core.SolrCore@6b6b1935
   [junit4]   2> 6562 T16 C3 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 6563 T16 C3 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 6722 T16 C3 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_3,generation=3}
   [junit4]   2> 6722 T16 C3 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 6747 T16 C3 oass.SolrIndexSearcher.<init> Opening 
Searcher@6c59562f[collection1] main
   [junit4]   2> 6748 T16 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 6761 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@6c59562f[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c1))}
   [junit4]   2> 6762 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=solr&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 6763 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=rocks&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 6764 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={event=newSearcher&distrib=false&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 6765 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 6765 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6c59562f[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c1))}
   [junit4]   2> 6766 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6767 T16 C3 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6768 T16 C3 oashd.DocBuilder.execute Time taken = 0:0:0.711
   [junit4]   2> 6769 T16 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={command=full-import&dataConfig=<dataConfig>+%0a<propertyWriter+dateFormat%3D"{'ts'+''yyyy-MM-dd+HH:mm:ss.SSSSSS''}"+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSimplePropertiesWriter">+%0a<entity+name%3D"SomeDates"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"select+1+as+id,+YEAR(${dih.last_index_time})+as+AYEAR_S+from+sysibm.sysdummy1+"+>%0a<field+column%3D"AYEAR_S"+name%3D"ayear_s"+/>+%0a</entity>%0a</document>+%0a</dataConfig>+%0a&synchronous=true&commit=true&indent=true&clean=true}
 {deleteByQuery=*:*,add=[1],commit=} 0 756
   [junit4]   2> 6770 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6784 T16 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&q=*:*&version=2.2&qt=standard&start=0} hits=1 
status=0 QTime=2 
   [junit4]   2> 6795 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6795 T16 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6800 T16 C3 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 6801 T16 C3 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 6801 T16 C3 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 6802 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6803 T16 C3 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 6804 T16 C3 oashd.JdbcDataSource$1.call Creating a connection 
for entity SomeDates with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 6806 T16 C3 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 6814 T16 C3 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 6814 T16 C3 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 6819 T16 C3 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_4,generation=4}
   [junit4]   2> 6819 T16 C3 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 6821 T16 C3 oass.SolrIndexSearcher.<init> Opening 
Searcher@73f5c083[collection1] main
   [junit4]   2> 6822 T16 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 6823 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@73f5c083[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c1))}
   [junit4]   2> 6824 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=solr&start=0} 
hits=0 status=0 QTime=1 
   [junit4]   2> 6825 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=rocks&start=0} 
hits=0 status=0 QTime=1 
   [junit4]   2> 6826 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={event=newSearcher&distrib=false&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 6826 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 6827 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@73f5c083[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c1))}
   [junit4]   2> 6829 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6829 T16 C3 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6830 T16 C3 oashd.DocBuilder.execute Time taken = 0:0:0.27
   [junit4]   2> 6830 T16 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={command=full-import&dataConfig=<dataConfig>+%0a<propertyWriter+dateFormat%3D"{'ts'+''yyyy-MM-dd+HH:mm:ss''}"+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSimplePropertiesWriter">+%0a<entity+name%3D"SomeDates"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"select+1+as+id,+YEAR(${dih.last_index_time})+as+AYEAR_S+from+sysibm.sysdummy1+"+>%0a<field+column%3D"AYEAR_S"+name%3D"ayear_s"+/>+%0a</entity>%0a</document>+%0a</dataConfig>+%0a&synchronous=true&commit=true&indent=true&clean=true}
 {deleteByQuery=*:*,add=[1],commit=} 0 34
   [junit4]   2> 6832 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6835 T16 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&q=*:*&version=2.2&qt=standard&start=0} hits=1 
status=0 QTime=0 
   [junit4]   2> 6839 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6839 T16 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6843 T16 C3 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 6843 T16 C3 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 6844 T16 C3 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 6844 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6845 T16 C3 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 6847 T16 C3 oashd.JdbcDataSource$1.call Creating a connection 
for entity SomeDates with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 6848 T16 C3 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 6861 T16 C3 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 6862 T16 C3 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 6866 T16 C3 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_5,generation=5}
   [junit4]   2> 6867 T16 C3 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 5
   [junit4]   2> 6869 T16 C3 oass.SolrIndexSearcher.<init> Opening 
Searcher@18623976[collection1] main
   [junit4]   2> 6870 T16 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 6870 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@18623976[collection1] 
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c1))}
   [junit4]   2> 6871 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=solr&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 6872 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=rocks&start=0} 
hits=0 status=0 QTime=1 
   [junit4]   2> 6872 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={event=newSearcher&distrib=false&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 6873 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 6873 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@18623976[collection1] 
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c1))}
   [junit4]   2> 6875 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6876 T16 C3 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6876 T16 C3 oashd.DocBuilder.execute Time taken = 0:0:0.31
   [junit4]   2> 6877 T16 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={command=full-import&dataConfig=<dataConfig>+%0a<propertyWriter+dateFormat%3D"yyyy-MM-dd+HH:mm:ss"+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSimplePropertiesWriter">+%0a<entity+name%3D"SomeDates"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"select+1+as+id,+YEAR('${dih.last_index_time}')+as+AYEAR_S+from+sysibm.sysdummy1+"+>%0a<field+column%3D"AYEAR_S"+name%3D"ayear_s"+/>+%0a</entity>%0a</document>+%0a</dataConfig>+%0a&synchronous=true&commit=true&indent=true&clean=true}
 {deleteByQuery=*:*,add=[1],commit=} 0 37
   [junit4]   2> 6878 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6881 T16 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&q=*:*&version=2.2&qt=standard&start=0} hits=1 
status=0 QTime=1 
   [junit4]   2> 6885 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6886 T16 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6889 T16 C3 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 6889 T16 C3 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 6890 T16 C3 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 6891 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6892 T16 C3 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 6893 T16 C3 oashd.JdbcDataSource$1.call Creating a connection 
for entity SomeDates with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 6895 T16 C3 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 6902 T16 C3 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 6902 T16 C3 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 6907 T16 C3 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@11a2bfe6 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_6,generation=6}
   [junit4]   2> 6907 T16 C3 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 6
   [junit4]   2> 6909 T16 C3 oass.SolrIndexSearcher.<init> Opening 
Searcher@43b34c70[collection1] main
   [junit4]   2> 6910 T16 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 6911 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@43b34c70[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c1))}
   [junit4]   2> 6911 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=solr&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 6912 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={event=newSearcher&distrib=false&rows=10&q=rocks&start=0} 
hits=0 status=0 QTime=0 
   [junit4]   2> 6913 T19 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={event=newSearcher&distrib=false&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 6913 T19 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 6914 T19 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@43b34c70[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c1))}
   [junit4]   2> 6915 T16 C3 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6916 T16 C3 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 6916 T16 C3 oashd.DocBuilder.execute Time taken = 0:0:0.25
   [junit4]   2> 6917 T16 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={command=full-import&dataConfig=<dataConfig>+%0a<propertyWriter+dateFormat%3D"yyyy-MM-dd+HH:mm:ss.SSSSSS"+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSimplePropertiesWriter">+%0a<entity+name%3D"SomeDates"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"select+1+as+id,+YEAR('${dih.last_index_time}')+as+AYEAR_S+from+sysibm.sysdummy1+"+>%0a<field+column%3D"AYEAR_S"+name%3D"ayear_s"+/>+%0a</entity>%0a</document>+%0a</dataConfig>+%0a&synchronous=true&commit=true&indent=true&clean=true}
 {deleteByQuery=*:*,add=[1],commit=} 0 31
   [junit4]   2> 6918 T16 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 6921 T16 C3 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&q=*:*&version=2.2&qt=standard&start=0} hits=1 
status=0 QTime=1 
   [junit4]   2> 7453 T16 oas.SolrTestCaseJ4.tearDown ###Ending 
testSimplePropertiesWriter
   [junit4]   2> 7477 T16 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 7477 T16 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=697396101
   [junit4]   2> 7491 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6b6b1935
   [junit4]   2> 7492 T16 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=5,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=5,cumulative_errors=0}
   [junit4]   2> 7493 T16 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 7493 T16 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 7493 T16 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 7495 T16 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 7495 T16 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 7496 T16 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001;done=false>>]
   [junit4]   2> 7497 T16 oasc.CachingDirectoryFactory.close Closing directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 7497 T16 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 7498 T16 oasc.CachingDirectoryFactory.close Closing directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestSimplePropertiesWriter-F95A17B6F9A43C6-001/init-core-data-001/index
   [junit4]   2> 6073 T15 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will 
linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> 26135 T15 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1 
thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSimplePropertiesWriter: 
   [junit4]   2>           1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:503)
   [junit4]   2>                at 
java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]   2>                at java.util.TimerThread.run(Timer.java:505)
   [junit4]   2> 26135 T15 ccr.ThreadLeakControl.tryToInterruptAll Starting to 
interrupt leaked threads:
   [junit4]   2>           1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
   [junit4]   2> 29137 T15 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There 
are still zombie threads that couldn't be terminated:
   [junit4]   2>           1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:503)
   [junit4]   2>                at 
java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]   2>                at java.util.TimerThread.run(Timer.java:505)
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=DefaultSimilarity, locale=es_PY, timezone=Indian/Maldives
   [junit4]   2> NOTE: Linux 3.13.0-32-generic amd64/Oracle Corporation 
1.7.0_65 (64-bit)/cpus=8,threads=2,free=90694208,total=126418944
   [junit4]   2> NOTE: All tests run in this JVM: [TestTemplateTransformer, 
TestSolrEntityProcessorUnit, TestSimplePropertiesWriter]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSimplePropertiesWriter -Dtests.seed=F95A17B6F9A43C6 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_PY 
-Dtests.timezone=Indian/Maldives -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | TestSimplePropertiesWriter (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.dataimport.TestSimplePropertiesWriter: 
   [junit4]    >    1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:503)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=17, name=Timer-0, state=WAITING, 
group=TGRP-TestSimplePropertiesWriter]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:503)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)
   [junit4] Completed on J1 in 29.24s, 1 test, 2 errors <<< FAILURES!

[...truncated 97 lines...]
   [junit4] Suite: 
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta
   [junit4]   2> Creating dataDir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 17503 T36 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (true)
   [junit4]   2> 18050 T36 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 18050 T36 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/'
   [junit4]   2> 18117 T36 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 18198 T36 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 18199 T36 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 18224 T36 oass.IndexSchema.readSchema [null] Schema 
name=dih_test
   [junit4]   2> 18268 T36 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 18269 T36 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 18270 T36 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 18272 T36 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 18273 T36 oasc.SolrResourceLoader.locateSolrHome using system 
property solr.solr.home: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001
   [junit4]   2> 18273 T36 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/'
   [junit4]   2> 18350 T36 oasc.CoreContainer.<init> New CoreContainer 232478012
   [junit4]   2> 18351 T36 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/]
   [junit4]   2> 18352 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 0
   [junit4]   2> 18353 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 18354 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 0
   [junit4]   2> 18354 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 18355 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 18355 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 18356 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 18356 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 18357 T36 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 18361 T36 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 18365 T36 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 18366 T36 oasl.LogWatcher.newRegisteredLogWatcher Registering 
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 18366 T36 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 18373 T38 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/'
   [junit4]   2> 18436 T38 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 18481 T38 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 18483 T38 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 18505 T38 oass.IndexSchema.readSchema [collection1] Schema 
name=dih_test
   [junit4]   2> 18559 T38 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 18561 T38 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 18562 T38 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 18563 T38 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/
   [junit4]   2> 18564 T38 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 18565 T38 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/,
 
dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/
   [junit4]   2> 18565 T38 oasc.SolrCore.<init> JMX monitoring not detected for 
core: collection1
   [junit4]   2> 18566 T38 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> 18566 T38 oasc.SolrCore.initListeners [collection1] Added 
SolrEventListener for firstSearcher: 
org.apache.solr.core.QuerySenderListener{queries=[]}
   [junit4]   2> 18567 T38 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 18568 T38 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index/
   [junit4]   2> 18568 T38 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 18569 T38 oasc.CachingDirectoryFactory.get return new 
directory for 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index
   [junit4]   2> 18571 T38 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 18572 T38 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 18575 T38 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "" (default)
   [junit4]   2> 18576 T38 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
   [junit4]   2> 18576 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 18577 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 18578 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 18578 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 18579 T38 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 18580 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
   [junit4]   2> 18580 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/search: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 18581 T38 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 18581 T38 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 18586 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18588 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18590 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18591 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18593 T38 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18596 T38 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 18597 T38 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 18598 T38 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2> 18599 T38 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 18600 T38 oass.SolrIndexSearcher.<init> Opening 
Searcher@442817ee[collection1] main
   [junit4]   2> 18601 T38 oasr.ManagedResourceStorage$FileStorageIO.configure 
File-based storage initialized to use dir: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 18601 T38 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/conf}
   [junit4]   2> 18602 T38 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 18603 T38 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 18604 T38 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using 
file:dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/core-home-001/collection1/conf
   [junit4]   2> 18604 T38 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 18605 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@442817ee[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 18605 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 18605 T38 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 18606 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@442817ee[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 18608 T36 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 18620 T36 oas.SolrTestCaseJ4.setUp ###Starting 
testDeltaImportWithoutInitialFullImport
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 
org.apache.solr.core.SolrCore@655490cd
   [junit4]   2> 18702 T36 C2 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 18704 T36 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 80
   [junit4]   2> 18711 T36 C2 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 18712 T36 C2 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_2,generation=2}
   [junit4]   2> 18713 T36 C2 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 18714 T36 C2 oass.SolrIndexSearcher.<init> Opening 
Searcher@1665ecd9[collection1] main
   [junit4]   2> 18714 T36 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18715 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@1665ecd9[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 18716 T39 C2 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=1 
   [junit4]   2> 18716 T39 C2 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=0 
   [junit4]   2> 18717 T39 C2 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 18717 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 18718 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1665ecd9[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 18718 T36 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> ASYNC  NEW_CORE C3 name=collection1 
org.apache.solr.core.SolrCore@655490cd
   [junit4]   2> 20232 T36 C3 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 20232 T36 C3 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 20233 T36 C3 oashd.DataImporter.doDeltaImport Starting Delta 
Import
   [junit4]   2> 20246 T36 C3 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20248 T36 C3 oashd.DocBuilder.doDelta Starting delta 
collection.
   [junit4]   2> 20251 T36 C3 oashd.DocBuilder.collectDelta Running 
ModifiedRowKey() for Entity: People
   [junit4]   2> 20253 T36 C3 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 20255 T36 C3 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 20323 T36 C3 oashd.DocBuilder.findMatchingPkColumn Resolving 
deltaQuery column 'ID' to match entity's declared pk 'People.ID'
   [junit4]   2> 20332 T36 C3 oashd.DocBuilder.collectDelta Completed 
ModifiedRowKey for Entity: People rows obtained : 20
   [junit4]   2> 20332 T36 C3 oashd.DocBuilder.collectDelta Completed 
DeletedRowKey for Entity: People rows obtained : 0
   [junit4]   2> 20333 T36 C3 oashd.DocBuilder.collectDelta Completed 
parentDeltaQuery for Entity: People
   [junit4]   2> 20494 T36 C3 oashd.DocBuilder.doDelta Delta Import completed 
successfully
   [junit4]   2> 20494 T36 C3 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 20495 T36 C3 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C4 name=collection1 
org.apache.solr.core.SolrCore@655490cd
   [junit4]   2> 20565 T36 C4 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_3,generation=3}
   [junit4]   2> 20566 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 20573 T36 C4 oass.SolrIndexSearcher.<init> Opening 
Searcher@5e33b980[collection1] main
   [junit4]   2> 20573 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 20574 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@5e33b980[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
   [junit4]   2> 20575 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=1 
   [junit4]   2> 20576 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=1 
   [junit4]   2> 20577 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 20577 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 20577 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5e33b980[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):C20))}
   [junit4]   2> 20578 T36 C4 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20579 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 20580 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.332
   [junit4]   2> 20580 T36 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={synchronous=true&commit=true&indent=true&command=delta-import&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false}
 {add=[16, 17, 18, 19, 20, 9, 8, 11, 10, 13, ... (20 adds)],commit=} 0 353
   [junit4]   2> 20586 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=*:*} hits=20 
status=0 QTime=3 
   [junit4]   2> 20602 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 20604 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 21135 T36 oas.SolrTestCaseJ4.tearDown ###Ending 
testDeltaImportWithoutInitialFullImport
   [junit4]   2> 21155 T36 oas.SolrTestCaseJ4.setUp ###Starting 
testWithSimpleTransformer
   [junit4]   2> 21157 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 21158 T36 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 2
   [junit4]   2> 21161 T36 C4 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 21163 T36 C4 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_4,generation=4}
   [junit4]   2> 21163 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 21165 T36 C4 oass.SolrIndexSearcher.<init> Opening 
Searcher@a829ef4[collection1] main
   [junit4]   2> 21166 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 21166 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@a829ef4[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 21167 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=0 
   [junit4]   2> 21168 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=1 
   [junit4]   2> 21168 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 21169 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 21169 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a829ef4[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 21170 T36 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 21662 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 21663 T36 C4 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 21663 T36 C4 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 21664 T36 C4 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 21666 T36 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 21668 T36 C4 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 21670 T36 C4 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 21719 T36 C4 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 21719 T36 C4 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 21730 T36 C4 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_5,generation=5}
   [junit4]   2> 21731 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 5
   [junit4]   2> 21734 T36 C4 oass.SolrIndexSearcher.<init> Opening 
Searcher@a4e8628[collection1] main
   [junit4]   2> 21735 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 21735 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@a4e8628[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):C20))}
   [junit4]   2> 21736 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=0 
   [junit4]   2> 21736 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=0 
   [junit4]   2> 21737 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 21738 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 21738 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a4e8628[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):C20))}
   [junit4]   2> 21739 T36 C4 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 21740 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 21740 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.75
   [junit4]   2> 21741 T36 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={synchronous=true&commit=true&indent=true&command=full-import&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"People.ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true}
 {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 
0 86
   [junit4]   2> 21764 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=AddAColumn_s:Added} 
hits=20 status=0 QTime=11 
   [junit4]   2> 21781 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=1 
   [junit4]   2> 21782 T36 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 21784 T36 oashd.SimplePropertiesWriter.readIndexerProperties 
Read the.properties
   [junit4]   2> 21839 T36 C4 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 21840 T36 C4 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 21840 T36 C4 oashd.DataImporter.doDeltaImport Starting Delta 
Import
   [junit4]   2> 21841 T36 C4 
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
   [junit4]   2> 21843 T36 C4 oashd.DocBuilder.doDelta Starting delta 
collection.
   [junit4]   2> 21844 T36 C4 oashd.DocBuilder.collectDelta Running 
ModifiedRowKey() for Entity: People
   [junit4]   2> 21845 T36 C4 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 21847 T36 C4 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 21882 T36 C4 oashd.DocBuilder.collectDelta Completed 
ModifiedRowKey for Entity: People rows obtained : 4
   [junit4]   2> 21883 T36 C4 oashd.DocBuilder.collectDelta Completed 
DeletedRowKey for Entity: People rows obtained : 2
   [junit4]   2> 21884 T36 C4 oashd.DocBuilder.collectDelta Completed 
parentDeltaQuery for Entity: People
   [junit4]   2> 21884 T36 C4 oashd.DocBuilder.deleteAll Deleting stale 
documents 
   [junit4]   2> 21885 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 19
   [junit4]   2> 21886 T36 C4 oashd.SolrWriter.deleteDoc Deleting document: 17
   [junit4]   2> 21923 T36 C4 oashd.DocBuilder.doDelta Delta Import completed 
successfully
   [junit4]   2> 21924 T36 C4 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 21924 T36 C4 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 22004 T36 C4 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_6,generation=6}
   [junit4]   2> 22005 T36 C4 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 6
   [junit4]   2> 22011 T36 C4 oass.SolrIndexSearcher.<init> Opening 
Searcher@7d585b43[collection1] main
   [junit4]   2> 22012 T36 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 22014 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@7d585b43[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):C20/4:delGen=1) 
Uninverting(_2(5.0):C4))}
   [junit4]   2> 22015 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=0 
   [junit4]   2> 22015 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=0 
   [junit4]   2> 22016 T39 C4 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=0 
   [junit4]   2> 22016 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 22017 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7d585b43[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):C20/4:delGen=1) 
Uninverting(_2(5.0):C4))}
   [junit4]   2> 22018 T36 C4 
oashd.SimplePropertiesWriter.readIndexerProperties Read the.properties
   [junit4]   2> 22018 T36 C4 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 22019 T36 C4 oashd.DocBuilder.execute Time taken = 0:0:0.177
   [junit4]   2> 22020 T36 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={synchronous=true&commit=true&indent=true&command=delta-import&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false}
 {delete=[19, 17],add=[1, 16, 1009, 1011],commit=} 0 187
   [junit4]   2> ASYNC  NEW_CORE C5 name=collection1 
org.apache.solr.core.SolrCore@655490cd
   [junit4]   2> 22034 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=AddAColumn_s:Added} 
hits=20 status=0 QTime=3 
   [junit4]   2> 22051 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 22052 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 22055 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:1011} hits=1 
status=0 QTime=1 
   [junit4]   2> 22060 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:1009} hits=1 
status=0 QTime=1 
   [junit4]   2> 22064 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:19} hits=0 
status=0 QTime=1 
   [junit4]   2> 22068 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:17} hits=0 
status=0 QTime=1 
   [junit4]   2> 22072 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:1} hits=1 
status=0 QTime=1 
   [junit4]   2> 22078 T36 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:16} hits=1 
status=0 QTime=1 
   [junit4]   2> 22591 T36 oas.SolrTestCaseJ4.tearDown ###Ending 
testWithSimpleTransformer
   [junit4]   2> 22609 T36 oas.SolrTestCaseJ4.setUp ###Starting 
testChildEntities
   [junit4]   2> 22610 T36 C5 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 22611 T36 C5 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 22615 T36 C5 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 22616 T36 C5 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_7,generation=7}
   [junit4]   2> 22617 T36 C5 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 7
   [junit4]   2> 22617 T36 C5 oass.SolrIndexSearcher.<init> Opening 
Searcher@5e354211[collection1] main
   [junit4]   2> 22618 T36 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 22619 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@5e354211[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 22619 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=0 
   [junit4]   2> 22620 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=0 
   [junit4]   2> 22621 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+query+from+solrconfig.xml}
 hits=0 status=0 QTime=1 
   [junit4]   2> 22621 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 22621 T39 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5e354211[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 22623 T36 C5 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 23008 T36 C5 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 23009 T36 C5 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 23010 T36 C5 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 23011 T36 C5 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 23012 T36 C5 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 23013 T36 C5 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 23015 T36 C5 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 23024 T36 C5 oashd.JdbcDataSource$1.call Creating a connection 
for entity Sports with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 23025 T36 C5 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 23233 T36 C5 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 23233 T36 C5 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 23296 T36 C5 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@7faf5fae 
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index),segFN=segments_8,generation=8}
   [junit4]   2> 23297 T36 C5 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 8
   [junit4]   2> 23299 T36 C5 oass.SolrIndexSearcher.<init> Opening 
Searcher@60dcb68c[collection1] main
   [junit4]   2> 23300 T36 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 23302 T39 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@60dcb68c[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):C20))}
   [junit4]   2> 23303 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=solr} 
hits=0 status=0 QTime=1 
   [junit4]   2> 23304 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={distrib=false&rows=10&start=0&event=newSearcher&q=rocks} 
hits=0 status=0 QTime=1 
   [junit4]   2> 23305 T39 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={distrib=false&event=newSearcher&q=static+newSearcher+warming+que

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

er"+directory%3D"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/tempDir-001"+filename%3D"the.properties"+/>%0a<dataSource+name%3D"hsqldb"+driver%3D"org.hsqldb.jdbcDriver"+url%3D"jdbc:hsqldb:mem:."+/>+%0a<dataSource+name%3D"derby"+driver%3D"org.apache.derby.jdbc.EmbeddedDriver"+url%3D"jdbc:derby:memory:derbyDB;territory%3Den_US"+/>+%0a<document+name%3D"TestSqlEntityProcessor">+%0a<entity+name%3D"People"+pk%3D"ID"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+deletedPkQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+"+deltaImportQuery%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+where+ID%3D${dih.delta.ID}+"+deltaQuery%3D"SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+last_modified+%26gt;%3D'${dih.People.last_index_time}'+UNION+DISTINCT+SELECT+ID+FROM+PEOPLE+WHERE+DELETED!%3D'Y'+AND+COUNTRY_CODE+IN+(SELECT+CODE+FROM+COUNTRIES+WHERE+last_modified+%26gt;%3D'${dih.People.last_index_time}')+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=false}
 {add=[13, 1006],commit=} 0 67
   [junit4]   2> 25233 T36 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=*:*} hits=21 
status=0 QTime=3 
   [junit4]   2> 25243 T36 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 25244 T36 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 25247 T36 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:1006} hits=1 
status=0 QTime=2 
   [junit4]   2> 25251 T36 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={rows=20&start=0&qt=standard&version=2.2&q=id:13} hits=1 
status=0 QTime=1 
   [junit4]   2> 25767 T36 oas.SolrTestCaseJ4.tearDown ###Ending 
testSingleEntity
   [junit4]   2> 25785 T36 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 25785 T36 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=232478012
   [junit4]   2> 25786 T36 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@655490cd
   [junit4]   2> 25786 T36 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=14,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=165,cumulative_deletesById=11,cumulative_deletesByQuery=9,cumulative_errors=0}
   [junit4]   2> 25787 T36 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 25787 T36 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 25787 T36 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 25789 T36 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 25790 T36 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 25790 T36 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 25791 T36 oasc.CachingDirectoryFactory.close Closing 
directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001/index
   [junit4]   2> 25791 T36 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001
 
[CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001;done=false>>]
   [junit4]   2> 25791 T36 oasc.CachingDirectoryFactory.close Closing 
directory: 
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessorDelta-F95A17B6F9A43C6-001/init-core-data-001
   [junit4]   2> 8304 T35 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will 
linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> 28365 T35 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1 
thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta: 
   [junit4]   2>           1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:503)
   [junit4]   2>                at 
java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]   2>                at java.util.TimerThread.run(Timer.java:505)
   [junit4]   2> 28365 T35 ccr.ThreadLeakControl.tryToInterruptAll Starting to 
interrupt leaked threads:
   [junit4]   2>           1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
   [junit4]   2> 31367 T35 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There 
are still zombie threads that couldn't be terminated:
   [junit4]   2>           1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:503)
   [junit4]   2>                at 
java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]   2>                at java.util.TimerThread.run(Timer.java:505)
   [junit4]   2> NOTE: test params are: codec=Lucene46, sim=DefaultSimilarity, 
locale=en_GB, timezone=America/Miquelon
   [junit4]   2> NOTE: Linux 3.13.0-32-generic amd64/Oracle Corporation 
1.7.0_65 (64-bit)/cpus=8,threads=2,free=73867792,total=126418944
   [junit4]   2> NOTE: All tests run in this JVM: [TestZKPropertiesWriter, 
TestSqlEntityProcessorDelta]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSqlEntityProcessorDelta -Dtests.seed=F95A17B6F9A43C6 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_GB 
-Dtests.timezone=America/Miquelon -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J0 | TestSqlEntityProcessorDelta (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessorDelta: 
   [junit4]    >    1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:503)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=37, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessorDelta]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:503)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([F95A17B6F9A43C6]:0)
   [junit4] Completed on J0 in 31.48s, 5 tests, 2 errors <<< FAILURES!

[...truncated 11 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:474: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:454: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:45: The following 
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:209: The 
following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:440: 
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:496: 
The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1307:
 The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922: 
There were test failures: 37 suites, 148 tests, 4 suite-level errors, 133 
ignored

Total time: 102 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0_65 
-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to