Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10995/
Java: 32bit/jdk1.8.0_20-ea-b23 -client -XX:+UseSerialGC
4 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestNestedChildren
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestNestedChildren: 1) Thread[id=127,
name=Timer-0, state=WAITING, group=TGRP-TestNestedChildren] 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.TestNestedChildren:
1) Thread[id=127, name=Timer-0, state=WAITING, group=TGRP-TestNestedChildren]
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([184FDFD8B787D35]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.dataimport.TestNestedChildren
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=127, name=Timer-0, state=WAITING, group=TGRP-TestNestedChildren]
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=127, name=Timer-0, state=WAITING, group=TGRP-TestNestedChildren]
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([184FDFD8B787D35]:0)
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=35,
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=35, 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([184FDFD8B787D35]: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=35,
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=35, 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([184FDFD8B787D35]:0)
Build Log:
[...truncated 15072 lines...]
[junit4] Suite: org.apache.solr.handler.dataimport.TestSqlEntityProcessor
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 7713 T34 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (true)
[junit4] 2> 8404 T34 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 8404 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/'
[junit4] 2> 8444 T34 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 8465 T34 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 8466 T34 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 8477 T34 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 8500 T34 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 8501 T34 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 8502 T34 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 8502 T34 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 8502 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001
[junit4] 2> 8503 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/'
[junit4] 2> 8535 T34 oasc.CoreContainer.<init> New CoreContainer 15508047
[junit4] 2> 8536 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/]
[junit4] 2> 8536 T34 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 8537 T34 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 8537 T34 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 8537 T34 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 8537 T34 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 8538 T34 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 8538 T34 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 8538 T34 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 8539 T34 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 8542 T34 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 8544 T34 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 8544 T34 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 8545 T34 oasc.CoreContainer.load Host Name:
[junit4] 2> 8548 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/'
[junit4] 2> 8586 T36 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 8609 T36 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 8609 T36 oass.IndexSchema.readSchema Reading Solr Schema from
dataimport-schema.xml
[junit4] 2> 8623 T36 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 8644 T36 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 8645 T36 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 8645 T36 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 8646 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/
[junit4] 2> 8646 T36 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 8646 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/
[junit4] 2> 8647 T36 oasc.SolrCore.<init> JMX monitoring not detected for
core: collection1
[junit4] 2> 8647 T36 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> 8650 T36 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 8650 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 8651 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index/
[junit4] 2> 8651 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 8651 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index
[junit4] 2> 8653 T36 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 8653 T36 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 8654 T36 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 8655 T36 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 8655 T36 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 8656 T36 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 8656 T36 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 8656 T36 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 8657 T36 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 8657 T36 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 8657 T36 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 8658 T36 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 8658 T36 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 8660 T36 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 8661 T36 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 8662 T36 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 8663 T36 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 8664 T36 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 8666 T36 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 8666 T36 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 8667 T36 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 8667 T36 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 8668 T36 oass.SolrIndexSearcher.<init> Opening
Searcher@1228efc[collection1] main
[junit4] 2> 8668 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 8669 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/conf}
[junit4] 2> 8669 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 8670 T36 oasr.ManagedResource.reloadFromStorage WARN No stored
data found for /rest/managed
[junit4] 2> 8670 T36 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.TestSqlEntityProcessor-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 8671 T36 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 8671 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1228efc[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 8671 T36 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 8671 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 8672 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1228efc[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 8673 T34 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 8679 T34 oas.SolrTestCaseJ4.setUp ###Starting testChildEntities
[junit4] 2> ASYNC NEW_CORE C4 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 8765 T34 C4 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 8767 T34 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 85
[junit4] 2> 8772 T34 C4 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 8773 T34 C4 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 8774 T34 C4 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 8774 T34 C4 oass.SolrIndexSearcher.<init> Opening
Searcher@12b2cc1[collection1] main
[junit4] 2> 8775 T34 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 8775 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@12b2cc1[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 8776 T37 C4 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> 8776 T37 C4 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> 8777 T37 C4 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> 8777 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 8778 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@12b2cc1[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 8778 T34 C4 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> ASYNC NEW_CORE C5 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 9009 T34 C5 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 9010 T34 C5 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 9011 T34 C5 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 9027 T34 C5 oashd.SimplePropertiesWriter.readIndexerProperties
WARN Unable to read: the.properties
[junit4] 2> 9029 T34 C5 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 9034 T34 C5 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 9034 T34 C5 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 9061 T34 C5 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:hsqldb:mem:.
[junit4] 2> 9062 T34 C5 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 9079 T34 C5 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 9079 T34 C5 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9088 T34 C5 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 9089 T34 C5 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 9091 T34 C5 oass.SolrIndexSearcher.<init> Opening
Searcher@18617e7[collection1] main
[junit4] 2> 9091 T34 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9092 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@18617e7[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
[junit4] 2> 9092 T37 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=0
[junit4] 2> 9093 T37 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> 9094 T37 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=1
[junit4] 2> 9094 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9094 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@18617e7[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c20))}
[junit4] 2> 9095 T34 C5 oashd.SimplePropertiesWriter.readIndexerProperties
WARN Unable to read: the.properties
[junit4] 2> 9095 T34 C5 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 9096 T34 C5 oashd.DocBuilder.execute Time taken = 0:0:0.67
[junit4] 2> 9096 T34 C5 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"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-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"Sports"+dataSource%3D"hsqldb"+processor%3D"SqlEntityProcessor"+query%3D"SELECT+ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+WHERE+DELETED+!%3D+'Y'+AND+PERSON_ID%3D${People.ID}+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_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 89
[junit4] 2> 9098 T34 C5 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C6 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 9125 T34 C6 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=8
[junit4] 2> 9131 T34 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=SPORT_NAME_mult_s:Sailing&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> 9134 T34 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 9137 T34 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9138 T34 C6 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9141 T34 oas.SolrTestCaseJ4.tearDown ###Ending
testChildEntities
[junit4] 2> 9149 T34 oas.SolrTestCaseJ4.setUp ###Starting
testCachedChildEntities
[junit4] 2> 9150 T34 C6 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 9151 T34 C6 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 9152 T34 C6 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9153 T34 C6 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> 9153 T34 C6 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 4
[junit4] 2> 9154 T34 C6 oass.SolrIndexSearcher.<init> Opening
Searcher@158cb2a[collection1] main
[junit4] 2> 9155 T34 C6 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9155 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@158cb2a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9156 T37 C6 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> 9156 T37 C6 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> 9157 T37 C6 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> 9157 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9157 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@158cb2a[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9158 T34 C6 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 9172 T34 C6 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 9173 T34 C6 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 9173 T34 C6 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 9174 T34 C6 oashd.SimplePropertiesWriter.readIndexerProperties
WARN Unable to read: the.properties
[junit4] 2> ASYNC NEW_CORE C7 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 9197 T34 C7 oasc.SolrResourceLoader.findClass WARN Solr loaded
a deprecated plugin/analysis class [CachedSqlEntityProcessor]. Please consult
documentation how to replace it accordingly.
[junit4] 2> 9199 T34 C7 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 9200 T34 C7 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 9200 T34 C7 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 9203 T34 C7 oashd.JdbcDataSource$1.call Creating a connection
for entity Sports with URL: jdbc:hsqldb:mem:.
[junit4] 2> 9204 T34 C7 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 9237 T34 C7 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 9237 T34 C7 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9243 T34 C7 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> 9244 T34 C7 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 5
[junit4] 2> 9246 T34 C7 oass.SolrIndexSearcher.<init> Opening
Searcher@10a3a90[collection1] main
[junit4] 2> 9246 T34 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9248 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@10a3a90[collection1]
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c20))}
[junit4] 2> 9248 T37 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> 9249 T37 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=0
[junit4] 2> 9250 T37 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=1
[junit4] 2> 9250 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9250 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@10a3a90[collection1]
main{UninvertingDirectoryReader(Uninverting(_1(5.0):c20))}
[junit4] 2> 9251 T34 C7 oashd.SimplePropertiesWriter.readIndexerProperties
WARN Unable to read: the.properties
[junit4] 2> 9251 T34 C7 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 9252 T34 C7 oashd.DocBuilder.execute Time taken = 0:0:0.77
[junit4] 2> 9252 T34 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"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-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"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"Sports"+dataSource%3D"hsqldb"+transformer%3D"AddAColumnTransformer"+newColumnName%3D"sportsAdded_s"+newColumnValue%3D"sport_added"+processor%3D"CachedSqlEntityProcessor"+cacheKey%3D"PERSON_ID"+cacheLookup%3D"People.ID"+query%3D"SELECT+ID,+PERSON_ID,+SPORT_NAME+FROM+PEOPLE_SPORTS+ORDER+BY+ID"+>+%0a<field+column%3D"SPORT_NAME"+name%3D"SPORT_NAME_mult_s"+/>+%0a<field+column%3D"id"+name%3D"SPORT_ID_mult_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 83
[junit4] 2> 9254 T34 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=20
status=0 QTime=1
[junit4] 2> 9263 T34 C7 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> 9268 T34 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=SPORT_NAME_mult_s:Sailing&qt=standard&start=0&rows=20&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> 9271 T34 C7 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=NAME_mult_s:Michael&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C8 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 9278 T34 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null
params={q=sportsAdded_s:sport_added&qt=standard&start=0&rows=20&version=2.2}
hits=20 status=0 QTime=1
[junit4] 2> 9286 T34 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9287 T34 C8 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 9288 T34 oas.SolrTestCaseJ4.tearDown ###Ending
testCachedChildEntities
[junit4] 2> 9303 T34 oas.SolrTestCaseJ4.setUp ###Starting testSingleEntity
[junit4] 2> 9304 T34 C8 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 9305 T34 C8 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 9307 T34 C8 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 9308 T34 C8 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2> 9308 T34 C8 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 6
[junit4] 2> 9309 T34 C8 oass.SolrIndexSearcher.<init> Opening
Searcher@12d35bc[collection1] main
[junit4] 2> 9310 T34 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 9310 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@12d35bc[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9311 T37 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> 9311 T37 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=0
[junit4] 2> 9312 T37 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> 9312 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 9312 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@12d35bc[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 9313 T34 C8 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> ASYNC NEW_CORE C9 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 11340 T34 C9 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 11342 T34 C9 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 11343 T34 C9 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 11344 T34 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 11345 T34 C9 oasu.DirectUpdateHandler2.deleteAll [collection1]
REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 11347 T34 C9 oashd.JdbcDataSource$1.call Creating a connection
for entity People with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 11349 T34 C9 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 11466 T34 C9 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 11467 T34 C9 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 11473 T34 C9 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_6,generation=6}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2> 11474 T34 C9 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 7
[junit4] 2> 11477 T34 C9 oass.SolrIndexSearcher.<init> Opening
Searcher@17c038[collection1] main
[junit4] 2> 11478 T34 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11479 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@17c038[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
[junit4] 2> 11480 T37 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> 11481 T37 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> 11481 T37 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> 11482 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 11482 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@17c038[collection1]
main{UninvertingDirectoryReader(Uninverting(_2(5.0):c20))}
[junit4] 2> 11484 T34 C9
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 11485 T34 C9 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 11485 T34 C9 oashd.DocBuilder.execute Time taken = 0:0:0.140
[junit4] 2> 11486 T34 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"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-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 149
[junit4] 2> ASYNC NEW_CORE C10 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 11542 T34 C10 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> 11548 T34 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 11549 T34 C10 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 12079 T34 oas.SolrTestCaseJ4.tearDown ###Ending
testSingleEntity
[junit4] 2> 12089 T34 oas.SolrTestCaseJ4.setUp ###Starting
testWithComplexTransformer
[junit4] 2> 12091 T34 C10 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 12091 T34 C10 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 12093 T34 C10 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12094 T34 C10 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_7,generation=7}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2> 12094 T34 C10 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 8
[junit4] 2> 12095 T34 C10 oass.SolrIndexSearcher.<init> Opening
Searcher@c5a37b[collection1] main
[junit4] 2> 12095 T34 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 12096 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@c5a37b[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 12096 T37 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> 12097 T37 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=1
[junit4] 2> 12097 T37 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> 12097 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 12097 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@c5a37b[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 12099 T34 C10 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 12111 T34 C10 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 12112 T34 C10 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 12112 T34 C10 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 12113 T34 C10
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 12113 T34 C10 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 12114 T34 C10 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 12115 T34 C10 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 12151 T34 C10 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 12151 T34 C10 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12164 T34 C10 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_8,generation=8}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2> 12165 T34 C10 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 9
[junit4] 2> 12166 T34 C10 oass.SolrIndexSearcher.<init> Opening
Searcher@1afdcfe[collection1] main
[junit4] 2> 12167 T34 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 12169 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1afdcfe[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c60))}
[junit4] 2> 12169 T37 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> 12170 T37 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> 12171 T37 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> 12171 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 12171 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@1afdcfe[collection1]
main{UninvertingDirectoryReader(Uninverting(_3(5.0):c60))}
[junit4] 2> 12172 T34 C10
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 12173 T34 C10 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 12173 T34 C10 oashd.DocBuilder.execute Time taken = 0:0:0.60
[junit4] 2> 12174 T34 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"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-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"hsqldb"+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 65
[junit4] 2> ASYNC NEW_CORE C11 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 12273 T34 C11 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&sort=id+asc&rows=60} hits=60 status=0 QTime=97
[junit4] 2> 12297 T34 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=11
[junit4] 2> 12301 T34 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=1
[junit4] 2> 12308 T34 C11 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=3
[junit4] 2> 12310 T34 C11 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> 12313 T34 C11 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 12314 T34 C11 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 12314 T34 oas.SolrTestCaseJ4.tearDown ###Ending
testWithComplexTransformer
[junit4] 2> 12322 T34 oas.SolrTestCaseJ4.setUp ###Starting
testWithSimpleTransformer
[junit4] 2> 12324 T34 C11 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 12324 T34 C11 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 12326 T34 C11 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12326 T34 C11 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_9,generation=9}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2> 12327 T34 C11 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 10
[junit4] 2> 12327 T34 C11 oass.SolrIndexSearcher.<init> Opening
Searcher@326eb8[collection1] main
[junit4] 2> 12328 T34 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 12328 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@326eb8[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 12329 T37 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=0
[junit4] 2> 12329 T37 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=0
[junit4] 2> 12330 T37 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> 12330 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 12330 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@326eb8[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 12331 T34 C11 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 12343 T34 C11 oashdc.DIHConfiguration.verifyWithSchema id is a
required field in SolrSchema . But not found in DataConfig
[junit4] 2> 12344 T34 C11 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 12344 T34 C11 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 12345 T34 C11
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> ASYNC NEW_CORE C12 name=collection1
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 12350 T34 C12 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 12352 T34 C12 oashd.JdbcDataSource$1.call Creating a
connection for entity People with URL: jdbc:hsqldb:mem:.
[junit4] 2> 12352 T34 C12 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 12358 T34 C12 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 12359 T34 C12 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12363 T34 C12 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_a,generation=10}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@16f8efa
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_b,generation=11}
[junit4] 2> 12363 T34 C12 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 11
[junit4] 2> 12365 T34 C12 oass.SolrIndexSearcher.<init> Opening
Searcher@15aa88d[collection1] main
[junit4] 2> 12365 T34 C12 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 12368 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@15aa88d[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
[junit4] 2> 12368 T37 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> 12369 T37 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> 12369 T37 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=0
[junit4] 2> 12369 T37 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 12370 T37 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@15aa88d[collection1]
main{UninvertingDirectoryReader(Uninverting(_4(5.0):c20))}
[junit4] 2> 12370 T34 C12
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
the.properties
[junit4] 2> 12371 T34 C12 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to the.properties
[junit4] 2> 12371 T34 C12 oashd.DocBuilder.execute Time taken = 0:0:0.25
[junit4] 2> 12372 T34 C12 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"/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-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"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>+%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 31
[junit4] 2> 12373 T34 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> 12377 T34 C12 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 12378 T34 C12 oasc.SolrCore.execute [collection1] webapp=null
path=null params={indent=true} status=0 QTime=0
[junit4] 2> 12379 T34 oas.SolrTestCaseJ4.tearDown ###Ending
testWithSimpleTransformer
[junit4] 2> 12402 T34 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 12402 T34 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=15508047
[junit4] 2> 12403 T34 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1b75474
[junit4] 2> 12403 T34 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> 12403 T34 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 12404 T34 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 12404 T34 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 12405 T34 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 12405 T34 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 12406 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001;done=false>>]
[junit4] 2> 12406 T34 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 12406 T34 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.TestSqlEntityProcessor-184FDFD8B787D35-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.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index;done=false>>]
[junit4] 2> 12407 T34 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J0/./temp/solr.handler.dataimport.TestSqlEntityProcessor-184FDFD8B787D35-001/init-core-data-001/index
[junit4] 2> 4713 T33 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 24773 T33 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestSqlEntityProcessor:
[junit4] 2> 1) Thread[id=35, 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> 24773 T33 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=35, name=Timer-0, state=WAITING,
group=TGRP-TestSqlEntityProcessor]
[junit4] 2> 27775 T33 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There
are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=35, 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=Lucene45,
sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=in,
timezone=America/Bogota
[junit4] 2> NOTE: Linux 3.13.0-32-generic i386/Oracle Corporation
1.8.0_20-ea (32-bit)/cpus=8,threads=2,free=13355312,total=42704896
[junit4] 2> NOTE: All tests run in this JVM: [TestZKPropertiesWriter,
TestSqlEntityProcessor]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSqlEntityProcessor -Dtests.seed=184FDFD8B787D35
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=in
-Dtests.timezone=America/Bogota -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | 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=35, 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([184FDFD8B787D35]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=35, 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([184FDFD8B787D35]:0)
[junit4] Completed on J0 in 28.00s, 6 tests, 2 errors, 1 skipped <<<
FAILURES!
[...truncated 67 lines...]
[junit4] Suite: org.apache.solr.handler.dataimport.TestNestedChildren
[junit4] 2> Creating dataDir:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 41164 T126 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(true) and clientAuth (false)
[junit4] 2> 41757 T126 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 41758 T126 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/'
[junit4] 2> 41793 T126 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 41812 T126 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 41813 T126 oass.IndexSchema.readSchema Reading Solr Schema
from dataimport-schema.xml
[junit4] 2> 41818 T126 oass.IndexSchema.readSchema [null] Schema
name=dih_test
[junit4] 2> 41837 T126 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 41837 T126 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 41838 T126 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 41838 T126 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 41839 T126 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001
[junit4] 2> 41839 T126 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/'
[junit4] 2> 41868 T126 oasc.CoreContainer.<init> New CoreContainer 2068683
[junit4] 2> 41868 T126 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/]
[junit4] 2> 41868 T126 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 41869 T126 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 41869 T126 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 41869 T126 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 41869 T126 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 41870 T126 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 41870 T126 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 41870 T126 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 41870 T126 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 41873 T126 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 41875 T126 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 41875 T126 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 41876 T126 oasc.CoreContainer.load Host Name:
[junit4] 2> 41878 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/'
[junit4] 2> 41903 T128 oasc.SolrConfig.<init> Using Lucene MatchVersion:
LUCENE_5_0
[junit4] 2> 41919 T128 oasc.SolrConfig.<init> Loaded SolrConfig:
dataimport-solrconfig.xml
[junit4] 2> 41920 T128 oass.IndexSchema.readSchema Reading Solr Schema
from dataimport-schema.xml
[junit4] 2> 41925 T128 oass.IndexSchema.readSchema [collection1] Schema
name=dih_test
[junit4] 2> 41941 T128 oass.IndexSchema.readSchema default search field in
schema is desc
[junit4] 2> 41941 T128 oass.IndexSchema.readSchema query parser default
operator is OR
[junit4] 2> 41942 T128 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 41942 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/
[junit4] 2> 41942 T128 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 41943 T128 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.TestNestedChildren-184FDFD8B787D35-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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/
[junit4] 2> 41943 T128 oasc.SolrCore.<init> JMX monitoring not detected
for core: collection1
[junit4] 2> 41943 T128 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> 41943 T128 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 41944 T128 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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 41944 T128 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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index/
[junit4] 2> 41944 T128 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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 41945 T128 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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index
[junit4] 2> 41947 T128 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 41948 T128 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 41950 T128 oasup.UpdateRequestProcessorChain.init creating
updateRequestProcessorChain "" (default)
[junit4] 2> 41950 T128 oasup.UpdateRequestProcessorChain.init inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 41950 T128 oasc.RequestHandlers.initHandlersFromConfig created
/update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41951 T128 oasc.RequestHandlers.initHandlersFromConfig created
/update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41951 T128 oasc.RequestHandlers.initHandlersFromConfig created
/update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41951 T128 oasc.RequestHandlers.initHandlersFromConfig created
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41951 T128 oasc.RequestHandlers.initHandlersFromConfig created
standard: solr.StandardRequestHandler
[junit4] 2> 41952 T128 oasc.RequestHandlers.initHandlersFromConfig created
/dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 41952 T128 oasc.RequestHandlers.initHandlersFromConfig created
/search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 41952 T128 oasc.RequestHandlers.initHandlersFromConfig WARN
Multiple requestHandler registered to the same name: /update ignoring:
org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41952 T128 oasc.RequestHandlers.initHandlersFromConfig created
/update: solr.UpdateRequestHandler
[junit4] 2> 41955 T128 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41956 T128 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41957 T128 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41958 T128 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41959 T128 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41960 T128 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 41960 T128 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 41961 T128 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 41962 T128 oasc.SolrDeletionPolicy.updateCommits newest commit
generation = 1
[junit4] 2> 41962 T128 oass.SolrIndexSearcher.<init> Opening
Searcher@6eca15[collection1] main
[junit4] 2> 41962 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 41963 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/conf}
[junit4] 2> 41963 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 41963 T128 oasr.ManagedResource.reloadFromStorage WARN No
stored data found for /rest/managed
[junit4] 2> 41964 T128 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.TestNestedChildren-184FDFD8B787D35-001/core-home-001/collection1/conf
[junit4] 2> 41964 T128 oasr.RestManager.init Initializing 0 registered
ManagedResources
[junit4] 2> 41964 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@6eca15[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 41964 T128 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 41965 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 41965 T129 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@6eca15[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 41966 T126 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 41970 T126 oas.SolrTestCaseJ4.setUp ###Starting test
[junit4] 2> ASYNC NEW_CORE C25 name=collection1
org.apache.solr.core.SolrCore@1de81a8
[junit4] 2> 41971 T126 C25 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 41972 T126 C25 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 41975 T126 C25 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 41976 T126 C25 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 41977 T126 C25 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 41977 T126 C25 oass.SolrIndexSearcher.<init> Opening
Searcher@9a28b3[collection1] main
[junit4] 2> 41978 T126 C25 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 41978 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@9a28b3[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 41979 T129 C25 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> 41979 T129 C25 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> 41980 T129 C25 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> 41980 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 41980 T129 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@9a28b3[collection1]
main{UninvertingDirectoryReader()}
[junit4] 2> 41980 T126 C25 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null params={} {commit=} 0 5
[junit4] 2> ASYNC NEW_CORE C26 name=collection1
org.apache.solr.core.SolrCore@1de81a8
[junit4] 2> 42835 T126 C26 oashdc.DIHConfiguration.verifyWithSchema id is
a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 42836 T126 C26 oashd.DataImporter.loadDataConfig Data
Configuration loaded successfully
[junit4] 2> 42837 T126 C26 oashd.DataImporter.doFullImport Starting Full
Import
[junit4] 2> 42837 T126 C26
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
dataimport.properties
[junit4] 2> 42838 T126 C26 oasu.DirectUpdateHandler2.deleteAll
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 42841 T126 C26 oashd.JdbcDataSource$1.call Creating a
connection for entity FIRST with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 42843 T126 C26 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C27 name=collection1
org.apache.solr.core.SolrCore@1de81a8
[junit4] 2> 43219 T126 C27 oashd.JdbcDataSource$1.call Creating a
connection for entity SECOND with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 43221 T126 C27 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 1
[junit4] 2> 43242 T126 C27 oashd.JdbcDataSource$1.call Creating a
connection for entity THIRD with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 43244 T126 C27 oashd.JdbcDataSource$1.call Time taken for
getConnection(): 0
[junit4] 2> 43251 T126 C27 oashd.DocBuilder.finish Import completed
successfully
[junit4] 2> 43252 T126 C27 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43261 T126 C27 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@61acee
lockFactory=NativeFSLockFactory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index),segFN=segments_3,generation=3}
[junit4] 2> 43261 T126 C27 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 43265 T126 C27 oass.SolrIndexSearcher.<init> Opening
Searcher@75186[collection1] main
[junit4] 2> 43265 T126 C27 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 43266 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@75186[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c1))}
[junit4] 2> 43266 T129 C27 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> 43267 T129 C27 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> 43267 T129 C27 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> 43267 T129 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 43267 T129 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@75186[collection1]
main{UninvertingDirectoryReader(Uninverting(_0(5.0):c1))}
[junit4] 2> 43268 T126 C27
oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read:
dataimport.properties
[junit4] 2> 43269 T126 C27 oashd.SimplePropertiesWriter.persist Wrote last
indexed time to dataimport.properties
[junit4] 2> 43269 T126 C27 oashd.DocBuilder.execute Time taken = 0:0:0.431
[junit4] 2> 43269 T126 C27 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=null
params={indent=true&synchronous=true&commit=true&dataConfig=<dataConfig>+%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"FIRST"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"++query%3D"select+1+as+id,+'PORK'+as+FIRST_S+from+sysibm.sysdummy1+"+>%0a++<field+column%3D"FIRST_S"+name%3D"first_s"+/>+%0a++<entity+name%3D"SECOND"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"++++query%3D"select+1+as+id,+2+as+SECOND_ID,+'BEEF'+as+SECOND_S+from+sysibm.sysdummy1+WHERE+1%3D${FIRST.ID}"+>%0a+++<field+column%3D"SECOND_S"+name%3D"second_s"+/>+%0a+++<entity+name%3D"THIRD"+processor%3D"SqlEntityProcessor"+dataSource%3D"derby"+++++query%3D"select+1+as+id,+'CHICKEN'+as+THIRD_S+from+sysibm.sysdummy1+WHERE+2%3D${SECOND.SECOND_ID}"+>%0a++++<field+column%3D"THIRD_S"+name%3D"third_s"+/>+%0a+++</entity>%0a++</entity>%0a</entity>%0a</document>+%0a</dataConfig>+%0a&clean=true&command=full-import}
{deleteByQuery=*:*,add=[1],commit=} 0 436
[junit4] 2> 43271 T126 C27 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=1
status=0 QTime=0
[junit4] 2> 43274 T126 C27 oasc.SolrCore.execute [collection1] webapp=null
path=null params={q=third_s:CHICKEN&qt=standard&start=0&rows=20&version=2.2}
hits=1 status=0 QTime=1
[junit4] 2> 43807 T126 oas.SolrTestCaseJ4.tearDown ###Ending test
[junit4] 2> 43848 T126 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 43849 T126 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=2068683
[junit4] 2> 43849 T126 oasc.SolrCore.close [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1de81a8
[junit4] 2> 43850 T126 oasu.DirectUpdateHandler2.close closing
DirectUpdateHandler2{commits=2,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
[junit4] 2> 43850 T126 oasu.SolrCoreState.decrefSolrCoreState Closing
SolrCoreState
[junit4] 2> 43850 T126 oasu.DefaultSolrCoreState.closeIndexWriter
SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 43851 T126 oasu.DefaultSolrCoreState.closeIndexWriter closing
IndexWriter with IndexWriterCloser
[junit4] 2> 43852 T126 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 43852 T126 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 43853 T126 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.TestNestedChildren-184FDFD8B787D35-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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001;done=false>>]
[junit4] 2> 43853 T126 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001
[junit4] 2> 43854 T126 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.TestNestedChildren-184FDFD8B787D35-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.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index;done=false>>]
[junit4] 2> 43854 T126 oasc.CachingDirectoryFactory.close Closing
directory:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/contrib/solr-dataimporthandler/test/J1/./temp/solr.handler.dataimport.TestNestedChildren-184FDFD8B787D35-001/init-core-data-001/index
[junit4] 2> 2718 T125 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will
linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 22781 T125 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1
thread leaked from SUITE scope at
org.apache.solr.handler.dataimport.TestNestedChildren:
[junit4] 2> 1) Thread[id=127, name=Timer-0, state=WAITING,
group=TGRP-TestNestedChildren]
[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> 22781 T125 ccr.ThreadLeakControl.tryToInterruptAll Starting to
interrupt leaked threads:
[junit4] 2> 1) Thread[id=127, name=Timer-0, state=WAITING,
group=TGRP-TestNestedChildren]
[junit4] 2> 25783 T125 ccr.ThreadLeakControl.tryToInterruptAll SEVERE
There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=127, name=Timer-0, state=WAITING,
group=TGRP-TestNestedChildren]
[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=Lucene46,
sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ar_JO,
timezone=Africa/Dar_es_Salaam
[junit4] 2> NOTE: Linux 3.13.0-32-generic i386/Oracle Corporation
1.8.0_20-ea (32-bit)/cpus=8,threads=2,free=23033272,total=50552832
[junit4] 2> NOTE: All tests run in this JVM: [TestFileListEntityProcessor,
TestXPathEntityProcessor, TestSolrEntityProcessorEndToEnd, TestJdbcDataSource,
TestEphemeralCache, TestErrorHandling, TestNestedChildren]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestNestedChildren
-Dtests.seed=184FDFD8B787D35 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=ar_JO -Dtests.timezone=Africa/Dar_es_Salaam
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestNestedChildren (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.handler.dataimport.TestNestedChildren:
[junit4] > 1) Thread[id=127, name=Timer-0, state=WAITING,
group=TGRP-TestNestedChildren]
[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([184FDFD8B787D35]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=127, name=Timer-0, state=WAITING,
group=TGRP-TestNestedChildren]
[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([184FDFD8B787D35]:0)
[junit4] Completed on J1 in 25.85s, 1 test, 2 errors <<< FAILURES!
[...truncated 41 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, 108
ignored
Total time: 101 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_20-ea-b23 -client
-XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
