Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4240/
Java: 32bit/jdk1.8.0_11 -server -XX:+UseSerialGC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestSqlEntityProcessor

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSqlEntityProcessor:     1) Thread[id=18, 
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessor]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:502)         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.TestSqlEntityProcessor: 
   1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:502)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([164D5C7DA1C92A86]:0)


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

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=18, 
name=Timer-0, state=WAITING, group=TGRP-TestSqlEntityProcessor]         at 
java.lang.Object.wait(Native Method)         at 
java.lang.Object.wait(Object.java:502)         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=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
        at java.lang.Object.wait(Native Method)
        at java.lang.Object.wait(Object.java:502)
        at java.util.TimerThread.mainLoop(Timer.java:526)
        at java.util.TimerThread.run(Timer.java:505)
        at __randomizedtesting.SeedInfo.seed([164D5C7DA1C92A86]:0)




Build Log:
[...truncated 15136 lines...]
   [junit4] Suite: org.apache.solr.handler.dataimport.TestSqlEntityProcessor
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001
   [junit4]   2> 12037 T17 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(false) and clientAuth (true)
   [junit4]   2> 14238 T17 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 14238 T17 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1\'
   [junit4]   2> 14305 T17 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 14338 T17 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 14339 T17 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 14347 T17 oass.IndexSchema.readSchema [null] Schema 
name=dih_test
   [junit4]   2> 14370 T17 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 14373 T17 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 14374 T17 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 14374 T17 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 14377 T17 oasc.SolrResourceLoader.locateSolrHome using system 
property solr.solr.home: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001
   [junit4]   2> 14377 T17 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\'
   [junit4]   2> 14427 T17 oasc.CoreContainer.<init> New CoreContainer 26977015
   [junit4]   2> 14427 T17 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\]
   [junit4]   2> 14428 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 0
   [junit4]   2> 14428 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 14428 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 0
   [junit4]   2> 14428 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 14429 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 14430 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 14430 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 14430 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 14431 T17 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 14431 T17 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 14431 T17 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 14432 T17 oasl.LogWatcher.newRegisteredLogWatcher Registering 
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 14433 T17 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 14437 T19 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1/'
   [junit4]   2> 14479 T19 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
LUCENE_5_0
   [junit4]   2> 14501 T19 oasc.SolrConfig.<init> Loaded SolrConfig: 
dataimport-solrconfig.xml
   [junit4]   2> 14502 T19 oass.IndexSchema.readSchema Reading Solr Schema from 
dataimport-schema.xml
   [junit4]   2> 14513 T19 oass.IndexSchema.readSchema [collection1] Schema 
name=dih_test
   [junit4]   2> 14537 T19 oass.IndexSchema.readSchema default search field in 
schema is desc
   [junit4]   2> 14538 T19 oass.IndexSchema.readSchema query parser default 
operator is OR
   [junit4]   2> 14538 T19 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 14539 T19 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1/
   [junit4]   2> 14540 T19 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 14541 T19 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1/,
 
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\
   [junit4]   2> 14542 T19 oasc.SolrCore.<init> JMX monitoring not detected for 
core: collection1
   [junit4]   2> 14542 T19 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> 14543 T19 oasc.SolrCore.initListeners [collection1] Added 
SolrEventListener for firstSearcher: 
org.apache.solr.core.QuerySenderListener{queries=[]}
   [junit4]   2> 14550 T19 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\
   [junit4]   2> 14551 T19 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index/
   [junit4]   2> 14551 T19 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index'
 doesn't exist. Creating new index...
   [junit4]   2> 14552 T19 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index
   [junit4]   2> 14557 T19 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_1,generation=1}
   [junit4]   2> 14557 T19 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 14558 T19 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "" (default)
   [junit4]   2> 14559 T19 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
   [junit4]   2> 14560 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 14560 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 14560 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 14561 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 14561 T19 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 14561 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
   [junit4]   2> 14563 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/search: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 14563 T19 oasc.RequestHandlers.initHandlersFromConfig WARN 
Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 14563 T19 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 14569 T19 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14571 T19 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14573 T19 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14576 T19 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14578 T19 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14579 T19 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 14579 T19 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 14581 T19 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_1,generation=1}
   [junit4]   2> 14581 T19 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 14582 T19 oass.SolrIndexSearcher.<init> Opening 
Searcher@e6006a[collection1] main
   [junit4]   2> 14583 T19 oasr.ManagedResourceStorage$FileStorageIO.configure 
File-based storage initialized to use dir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1\conf
   [junit4]   2> 14584 T19 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1\conf}
   [junit4]   2> 14584 T19 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1\conf
   [junit4]   2> 14586 T19 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 14587 T19 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using 
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\core-home-001\collection1\conf
   [junit4]   2> 14587 T19 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 14588 T19 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 14590 T17 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 14598 T17 oas.SolrTestCaseJ4.setUp ###Starting 
testCachedChildEntities
   [junit4]   2> 14599 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@e6006a[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 14599 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 14600 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@e6006a[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> ASYNC  NEW_CORE C5 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 14804 T17 C5 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 14809 T17 C5 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 204
   [junit4]   2> 14818 T17 C5 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14820 T17 C5 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_2,generation=2}
   [junit4]   2> 14821 T17 C5 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 14821 T17 C5 oass.SolrIndexSearcher.<init> Opening 
Searcher@db22e8[collection1] main
   [junit4]   2> 14821 T17 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14822 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@db22e8[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 14827 T20 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=4 
   [junit4]   2> 14828 T20 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 14829 T20 C5 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 14830 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 14830 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@db22e8[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 14831 T17 C5 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> ASYNC  NEW_CORE C6 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 18186 T17 C6 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 18186 T17 C6 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 18187 T17 C6 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 18189 T17 C6 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 18317 T17 C6 oasc.SolrResourceLoader.findClass WARN Solr 
loaded a deprecated plugin/analysis class [CachedSqlEntityProcessor]. Please 
consult documentation how to replace it accordingly.
   [junit4]   2> 18318 T17 C6 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 18328 T17 C6 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 18331 T17 C6 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> ASYNC  NEW_CORE C7 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 18500 T17 C7 oashd.JdbcDataSource$1.call Creating a connection 
for entity Countries with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 18502 T17 C7 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 1
   [junit4]   2> 18674 T17 C7 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 18675 T17 C7 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 18684 T17 C7 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_3,generation=3}
   [junit4]   2> 18684 T17 C7 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 18687 T17 C7 oass.SolrIndexSearcher.<init> Opening 
Searcher@1750042[collection1] main
   [junit4]   2> 18687 T17 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 18689 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@1750042[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
   [junit4]   2> 18690 T20 C7 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 18691 T20 C7 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 18691 T20 C7 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 18693 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 18693 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1750042[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
   [junit4]   2> 18695 T17 C7 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 18697 T17 C7 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 18697 T17 C7 oashd.DocBuilder.execute Time taken = 0:0:0.549
   [junit4]   2> 18698 T17 C7 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-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'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Countries"+pk%3D"CODE"+dataSource%3D"derby"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"countryAdded_s"+newColumnValue%3D"country_added"+processor%3D"CachedSqlEntityProcessor"+where%3D"CODE%3DPeople.COUNTRY_CODE"+query%3D"SELECT+CODE,+COUNTRY_NAME+FROM+COUNTRIES"+>+%0a<field+column%3D"CODE"+name%3D"COUNTRY_CODE_s"+/>+%0a<field+column%3D"COUNTRY_NAME"+name%3D"COUNTRY_NAME_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
 {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 
0 516
   [junit4]   2> ASYNC  NEW_CORE C8 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 18799 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20 
status=0 QTime=2 
   [junit4]   2> 18873 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=NAME_mult_s:Jayden&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=3 
   [junit4]   2> 18924 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=COUNTRY_CODES_mult_s:NR&qt=standard&start=0&rows=20&version=2.2} 
hits=2 status=0 QTime=1 
   [junit4]   2> 18934 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=countryAdded_s:country_added&qt=standard&start=0&rows=20&version=2.2} 
hits=20 status=0 QTime=5 
   [junit4]   2> 18949 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 18950 T17 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 19513 T17 oas.SolrTestCaseJ4.tearDown ###Ending 
testCachedChildEntities
   [junit4]   2> 19522 T17 oas.SolrTestCaseJ4.setUp ###Starting 
testChildEntities
   [junit4]   2> 19525 T17 C8 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 19526 T17 C8 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 19528 T17 C8 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 19529 T17 C8 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_4,generation=4}
   [junit4]   2> 19530 T17 C8 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 19530 T17 C8 oass.SolrIndexSearcher.<init> Opening 
Searcher@1115819[collection1] main
   [junit4]   2> 19532 T17 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 19533 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@1115819[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 19533 T20 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 19534 T20 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 19534 T20 C8 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 19534 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 19535 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1115819[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 19537 T17 C8 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> ASYNC  NEW_CORE C9 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 20197 T17 C9 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 20197 T17 C9 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 20200 T17 C9 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 20202 T17 C9 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20203 T17 C9 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 20204 T17 C9 oashd.JdbcDataSource$1.call Creating a connection 
for entity People with URL: jdbc:hsqldb:mem:.
   [junit4]   2> 20204 T17 C9 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 0
   [junit4]   2> 20213 T17 C9 oashd.JdbcDataSource$1.call Creating a connection 
for entity Countries with URL: jdbc:hsqldb:mem:.
   [junit4]   2> 20213 T17 C9 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 0
   [junit4]   2> 20238 T17 C9 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 20239 T17 C9 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 20247 T17 C9 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_5,generation=5}
   [junit4]   2> 20248 T17 C9 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 5
   [junit4]   2> 20252 T17 C9 oass.SolrIndexSearcher.<init> Opening 
Searcher@1341a7f[collection1] main
   [junit4]   2> 20252 T17 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 20254 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@1341a7f[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c20))}
   [junit4]   2> 20255 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 20255 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 20256 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 20257 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 20257 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1341a7f[collection1] 
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c20))}
   [junit4]   2> 20259 T17 C9 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20259 T17 C9 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 20260 T17 C9 oashd.DocBuilder.execute Time taken = 0:0:0.63
   [junit4]   2> 20261 T17 C9 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-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"hsqldb"+transformer%3D"AddAColumnTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+>+%0a<field+column%3D"NAME"+name%3D"NAME_mult_s"+/>+%0a<field+column%3D"COUNTRY_CODE"+name%3D"COUNTRY_CODES_mult_s"+/>+%0a<entity+name%3D"Countries"+pk%3D"Countries.CODE"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"countryAdded_s"+newColumnValue%3D"country_added"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+CODE,+COUNTRY_NAME+FROM+COUNTRIES+WHERE+DELETED+!%3D+'Y'+AND+CODE%3D'${People.COUNTRY_CODE}'+"+>+%0a<field+column%3D"CODE"+name%3D"COUNTRY_CODE_s"+/>+%0a<field+column%3D"COUNTRY_NAME"+name%3D"COUNTRY_NAME_s"+/>+%0a</entity>+%0a</entity>+%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
 {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 
0 70
   [junit4]   2> 20278 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20 
status=0 QTime=3 
   [junit4]   2> 20314 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2} 
hits=20 status=0 QTime=6 
   [junit4]   2> 20321 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=NAME_mult_s:Jayden&qt=standard&start=0&rows=20&version=2.2} 
hits=1 status=0 QTime=0 
   [junit4]   2> 20328 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=COUNTRY_CODES_mult_s:NR&qt=standard&start=0&rows=20&version=2.2} 
hits=2 status=0 QTime=1 
   [junit4]   2> 20339 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=countryAdded_s:country_added&qt=standard&start=0&rows=20&version=2.2} 
hits=20 status=0 QTime=4 
   [junit4]   2> 20348 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 20349 T17 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 20363 T17 oas.SolrTestCaseJ4.tearDown ###Ending 
testChildEntities
   [junit4]   2> 20386 T17 oas.SolrTestCaseJ4.setUp ###Starting 
testWithSimpleTransformer
   [junit4]   2> 20390 T17 C9 oasu.DirectUpdateHandler2.deleteAll [collection1] 
REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 20390 T17 C9 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 20393 T17 C9 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 20394 T17 C9 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_5,generation=5}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_6,generation=6}
   [junit4]   2> 20395 T17 C9 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 6
   [junit4]   2> 20395 T17 C9 oass.SolrIndexSearcher.<init> Opening 
Searcher@30d684[collection1] main
   [junit4]   2> 20396 T17 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 20396 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@30d684[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 20397 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 20398 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 20398 T20 C9 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 20399 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 20399 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@30d684[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 20401 T17 C9 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> ASYNC  NEW_CORE C10 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 20877 T17 C10 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 20878 T17 C10 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 20879 T17 C10 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 20882 T17 C10 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20882 T17 C10 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 20884 T17 C10 oashd.JdbcDataSource$1.call Creating a 
connection for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 20884 T17 C10 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 0
   [junit4]   2> 20915 T17 C10 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 20915 T17 C10 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 20930 T17 C10 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_6,generation=6}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_7,generation=7}
   [junit4]   2> 20930 T17 C10 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 7
   [junit4]   2> 20936 T17 C10 oass.SolrIndexSearcher.<init> Opening 
Searcher@68bd2[collection1] main
   [junit4]   2> 20937 T17 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 20941 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@68bd2[collection1] 
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
   [junit4]   2> 20941 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 20942 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 20943 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=0 
   [junit4]   2> 20943 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 20943 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@68bd2[collection1] 
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
   [junit4]   2> 20943 T17 C10 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 20943 T17 C10 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 20945 T17 C10 oashd.DocBuilder.execute Time taken = 0:0:0.67
   [junit4]   2> 20945 T17 C10 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-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'+"+>+%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&command=full-import}
 {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 
0 74
   [junit4]   2> 20961 T17 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2} 
hits=20 status=0 QTime=5 
   [junit4]   2> 20968 T17 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=1 
   [junit4]   2> 20969 T17 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 21450 T17 oas.SolrTestCaseJ4.tearDown ###Ending 
testWithSimpleTransformer
   [junit4]   2> 21492 T17 oas.SolrTestCaseJ4.setUp ###Starting 
testWithComplexTransformer
   [junit4]   2> 21498 T17 C10 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 21498 T17 C10 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 2
   [junit4]   2> 21499 T17 C10 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 21501 T17 C10 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_7,generation=7}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_8,generation=8}
   [junit4]   2> 21501 T17 C10 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 8
   [junit4]   2> 21501 T17 C10 oass.SolrIndexSearcher.<init> Opening 
Searcher@170f4ab[collection1] main
   [junit4]   2> 21502 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@170f4ab[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 21503 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 21524 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=21 
   [junit4]   2> 21527 T20 C10 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=1 
   [junit4]   2> 21527 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 21528 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@170f4ab[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 21530 T17 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 21530 T17 C10 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 31
   [junit4]   2> ASYNC  NEW_CORE C11 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 21765 T17 C11 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 21766 T17 C11 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 21766 T17 C11 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 21768 T17 C11 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 21769 T17 C11 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 21770 T17 C11 oashd.JdbcDataSource$1.call Creating a 
connection for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 21770 T17 C11 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 0
   [junit4]   2> 21893 T17 C11 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 21893 T17 C11 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 21910 T17 C11 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_8,generation=8}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_9,generation=9}
   [junit4]   2> 21911 T17 C11 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 9
   [junit4]   2> 21914 T17 C11 oass.SolrIndexSearcher.<init> Opening 
Searcher@eedbaa[collection1] main
   [junit4]   2> 21920 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@eedbaa[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c60))}
   [junit4]   2> 21921 T20 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 21922 T20 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 21923 T20 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=1 
   [junit4]   2> 21923 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 21923 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@eedbaa[collection1] 
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c60))}
   [junit4]   2> 21924 T17 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 21924 T17 C11 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 21924 T17 C11 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 21925 T17 C11 oashd.DocBuilder.execute Time taken = 0:0:0.167
   [junit4]   2> 21925 T17 C11 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-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"TripleThreatTransformer"+query%3D"SELECT+ID,+NAME,+COUNTRY_CODE+FROM+PEOPLE+WHERE+DELETED+!%3D+'Y'+"+>+%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&command=full-import}
 {deleteByQuery=*:*,add=[1, TripleThreat-1-1, TripleThreat-2-1, 2, 
TripleThreat-1-2, TripleThreat-2-2, 3, TripleThreat-1-3, TripleThreat-2-3, 4, 
... (60 adds)],commit=} 0 168
   [junit4]   2> 22275 T17 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=*:*&sort=id+asc&rows=60} hits=60 status=0 QTime=323 
   [junit4]   2> 22291 T17 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=id:TripleThreat-1-*&qt=standard&start=0&rows=20&version=2.2} hits=20 
status=0 QTime=2 
   [junit4]   2> 22302 T17 C11 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=id:TripleThreat-2-*&qt=standard&start=0&rows=20&version=2.2} hits=20 
status=0 QTime=2 
   [junit4]   2> ASYNC  NEW_CORE C12 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 22357 T17 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=%2Bid:TripleThreat-1-3+%2BNAME_mult_s:Michael+%2BNAME_mult_s:leahciM++%2BCOUNTRY_CODES_mult_s:NR+%2BCOUNTRY_CODES_mult_s:RN&qt=standard&start=0&rows=20&version=2.2}
 hits=1 status=0 QTime=12 
   [junit4]   2> 22359 T17 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=AddAColumn_s:Added&qt=standard&start=0&rows=20&version=2.2} 
hits=20 status=0 QTime=0 
   [junit4]   2> 22372 T17 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 22372 T17 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 22856 T17 oas.SolrTestCaseJ4.tearDown ###Ending 
testWithComplexTransformer
   [junit4]   2> 22883 T17 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
   [junit4]   2> 22890 T17 C12 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 22890 T17 C12 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 22891 T17 C12 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 22892 T17 C12 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_9,generation=9}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_a,generation=10}
   [junit4]   2> 22892 T17 C12 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 10
   [junit4]   2> 22893 T17 C12 oass.SolrIndexSearcher.<init> Opening 
Searcher@217905[collection1] main
   [junit4]   2> 22894 T17 C12 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 22898 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@217905[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 22898 T20 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 22899 T20 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 22900 T20 C12 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=1 
   [junit4]   2> 22900 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 22900 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@217905[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 22904 T17 C12 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> ASYNC  NEW_CORE C13 name=collection1 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 23065 T17 C13 oashdc.DIHConfiguration.verifyWithSchema id is a 
required field in SolrSchema . But not found in DataConfig
   [junit4]   2> 23065 T17 C13 oashd.DataImporter.loadDataConfig Data 
Configuration loaded successfully
   [junit4]   2> 23065 T17 C13 oashd.DataImporter.doFullImport Starting Full 
Import
   [junit4]   2> 23069 T17 C13 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 23069 T17 C13 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 23070 T17 C13 oashd.JdbcDataSource$1.call Creating a 
connection for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
   [junit4]   2> 23072 T17 C13 oashd.JdbcDataSource$1.call Time taken for 
getConnection(): 0
   [junit4]   2> 23087 T17 C13 oashd.DocBuilder.finish Import completed 
successfully
   [junit4]   2> 23087 T17 C13 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 23089 T17 C13 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_a,generation=10}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@156b7de 
lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index),segFN=segments_b,generation=11}
   [junit4]   2> 23089 T17 C13 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 11
   [junit4]   2> 23091 T17 C13 oass.SolrIndexSearcher.<init> Opening 
Searcher@4c72ed[collection1] main
   [junit4]   2> 23091 T17 C13 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 23098 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener sending requests to Searcher@4c72ed[collection1] 
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
   [junit4]   2> 23099 T20 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=solr&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=1 
   [junit4]   2> 23099 T20 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=rocks&distrib=false&start=0&rows=10&event=newSearcher} 
hits=0 status=0 QTime=0 
   [junit4]   2> 23100 T20 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null 
params={q=static+newSearcher+warming+query+from+solrconfig.xml&distrib=false&event=newSearcher}
 hits=0 status=0 QTime=1 
   [junit4]   2> 23100 T20 oasc.QuerySenderListener.newSearcher 
QuerySenderListener done.
   [junit4]   2> 23100 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4c72ed[collection1] 
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
   [junit4]   2> 23101 T17 C13 
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: 
the.properties
   [junit4]   2> 23101 T17 C13 oashd.SimplePropertiesWriter.persist Wrote last 
indexed time to the.properties
   [junit4]   2> 23102 T17 C13 oashd.DocBuilder.execute Time taken = 0:0:0.32
   [junit4]   2> 23103 T17 C13 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null 
params={indent=true&synchronous=true&commit=true&dataConfig=%0a<dataConfig>+%0a<propertyWriter+type%3D"SimplePropertiesWriter"+directory%3D"C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-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'+"+>+%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&command=full-import}
 {deleteByQuery=*:*,add=[1, 2, 3, 4, 5, 6, 7, 8, 9, 10, ... (20 adds)],commit=} 
0 45
   [junit4]   2> 23113 T17 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20 
status=0 QTime=3 
   [junit4]   2> 23117 T17 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 23118 T17 C13 oasc.SolrCore.execute [collection1] webapp=null 
path=null params={indent=true} status=0 QTime=0 
   [junit4]   2> 23636 T17 oas.SolrTestCaseJ4.tearDown ###Ending 
testSingleEntity
   [junit4]   2> 23735 T17 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 23735 T17 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=26977015
   [junit4]   2> 23736 T17 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@14f3105
   [junit4]   2> 23736 T17 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=10,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=140,cumulative_deletesById=0,cumulative_deletesByQuery=10,cumulative_errors=0}
   [junit4]   2> 23736 T17 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 23736 T17 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 23736 T17 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 23740 T17 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 23742 T17 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 23742 T17 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index;done=false>>]
   [junit4]   2> 23743 T17 oasc.CachingDirectoryFactory.close Closing 
directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\index
   [junit4]   2> 23743 T17 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\;done=false>>]
   [junit4]   2> 23744 T17 oasc.CachingDirectoryFactory.close Closing 
directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestSqlEntityProcessor-164D5C7DA1C92A86-001\init-core-data-001\
   [junit4]   2> 11937 T16 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will 
linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> 32006 T16 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1 
thread leaked from SUITE scope at 
org.apache.solr.handler.dataimport.TestSqlEntityProcessor: 
   [junit4]   2>           1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:502)
   [junit4]   2>                at 
java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]   2>                at java.util.TimerThread.run(Timer.java:505)
   [junit4]   2> 32007 T16 ccr.ThreadLeakControl.tryToInterruptAll Starting to 
interrupt leaked threads:
   [junit4]   2>           1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
   [junit4]   2> 35007 T16 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There 
are still zombie threads that couldn't be terminated:
   [junit4]   2>           1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
   [junit4]   2>                at java.lang.Object.wait(Native Method)
   [junit4]   2>                at java.lang.Object.wait(Object.java:502)
   [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=it_CH, timezone=Asia/Jakarta
   [junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_11 
(32-bit)/cpus=2,threads=2,free=16221456,total=47816704
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestFileListWithLineEntityProcessor, TestSqlEntityProcessor]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSqlEntityProcessor -Dtests.seed=164D5C7DA1C92A86 
-Dtests.slow=true -Dtests.locale=it_CH -Dtests.timezone=Asia/Jakarta 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s | TestSqlEntityProcessor (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.handler.dataimport.TestSqlEntityProcessor: 
   [junit4]    >    1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:502)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([164D5C7DA1C92A86]:0)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=18, name=Timer-0, state=WAITING, 
group=TGRP-TestSqlEntityProcessor]
   [junit4]    >         at java.lang.Object.wait(Native Method)
   [junit4]    >         at java.lang.Object.wait(Object.java:502)
   [junit4]    >         at java.util.TimerThread.mainLoop(Timer.java:526)
   [junit4]    >         at java.util.TimerThread.run(Timer.java:505)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([164D5C7DA1C92A86]:0)
   [junit4] Completed in 35.41s, 6 tests, 2 errors, 1 skipped <<< FAILURES!

[...truncated 114 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:454: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:209: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:440:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1298:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:922:
 There were test failures: 37 suites, 148 tests, 2 suite-level errors, 138 
ignored

Total time: 157 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_11 -server 
-XX:+UseSerialGC
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