You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/08/11 09:38:38 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_20-ea-b23) -
Build # 4242 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4242/
Java: 32bit/jdk1.8.0_20-ea-b23 -client -XX:+UseConcMarkSweepGC
2 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=77, 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=77, 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([73B1D5EA76876E2F]: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=77, 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=77, 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([73B1D5EA76876E2F]:0)
Build Log:
[...truncated 15020 lines...]
[junit4] Suite: org.apache.solr.handler.dataimport.TestNestedChildren
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001
[junit4] 2> 38430 T76 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 40581 T76 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 40581 T76 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1\'
[junit4] 2> 40671 T76 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 40700 T76 oasc.SolrConfig.<init> Loaded SolrConfig: dataimport-solrconfig.xml
[junit4] 2> 40702 T76 oass.IndexSchema.readSchema Reading Solr Schema from dataimport-schema.xml
[junit4] 2> 40711 T76 oass.IndexSchema.readSchema [null] Schema name=dih_test
[junit4] 2> 40751 T76 oass.IndexSchema.readSchema default search field in schema is desc
[junit4] 2> 40753 T76 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 40757 T76 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 40759 T76 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 40759 T76 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001
[junit4] 2> 40759 T76 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\'
[junit4] 2> 40843 T3 oashd.JdbcDataSource.finalize ERROR JdbcDataSource was not closed prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!!
[junit4] 2> 40843 T3 oashd.JdbcDataSource.finalize ERROR JdbcDataSource was not closed prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!!
[junit4] 2> 40861 T76 oasc.CoreContainer.<init> New CoreContainer 23558811
[junit4] 2> 40861 T76 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\]
[junit4] 2> 40863 T76 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 40863 T76 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 40863 T76 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 40864 T76 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 40864 T76 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 40864 T76 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 40864 T76 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 40864 T76 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 40865 T76 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 40879 T76 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 40884 T76 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 40884 T76 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 40884 T76 oasc.CoreContainer.load Host Name:
[junit4] 2> 40892 T78 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1/'
[junit4] 2> 40941 T78 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 40964 T78 oasc.SolrConfig.<init> Loaded SolrConfig: dataimport-solrconfig.xml
[junit4] 2> 40964 T78 oass.IndexSchema.readSchema Reading Solr Schema from dataimport-schema.xml
[junit4] 2> 40973 T78 oass.IndexSchema.readSchema [collection1] Schema name=dih_test
[junit4] 2> 40994 T78 oass.IndexSchema.readSchema default search field in schema is desc
[junit4] 2> 40994 T78 oass.IndexSchema.readSchema query parser default operator is OR
[junit4] 2> 40996 T78 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 40996 T78 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1/
[junit4] 2> 40997 T78 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 40998 T78 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1/, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\
[junit4] 2> 40998 T78 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 41000 T78 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> 41000 T78 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 41001 T78 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\
[junit4] 2> 41002 T78 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index/
[junit4] 2> 41002 T78 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index' doesn't exist. Creating new index...
[junit4] 2> 41003 T78 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index
[junit4] 2> 41007 T78 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_1,generation=1}
[junit4] 2> 41007 T78 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 41009 T78 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "" (default)
[junit4] 2> 41009 T78 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "" (default)
[junit4] 2> 41010 T78 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41010 T78 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41010 T78 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41012 T78 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41012 T78 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 41013 T78 oasc.RequestHandlers.initHandlersFromConfig created /dataimport: org.apache.solr.handler.dataimport.DataImportHandler
[junit4] 2> 41013 T78 oasc.RequestHandlers.initHandlersFromConfig created /search: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 41013 T78 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 41014 T78 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 41020 T78 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41022 T78 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41024 T78 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41025 T78 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41027 T78 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 41030 T78 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 41031 T78 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 41031 T78 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_1,generation=1}
[junit4] 2> 41032 T78 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 41032 T78 oass.SolrIndexSearcher.<init> Opening Searcher@12c63d9[collection1] main
[junit4] 2> 41033 T78 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1\conf
[junit4] 2> 41034 T78 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1\conf}
[junit4] 2> 41034 T78 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1\conf
[junit4] 2> 41038 T78 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 41039 T78 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\core-home-001\collection1\conf
[junit4] 2> 41040 T78 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 41041 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@12c63d9[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 41042 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 41042 T79 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12c63d9[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 41042 T78 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 41047 T76 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 41054 T76 oas.SolrTestCaseJ4.setUp ###Starting test
[junit4] 2> ASYNC NEW_CORE C30 name=collection1 org.apache.solr.core.SolrCore@53c66
[junit4] 2> 41088 T76 C30 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 41090 T76 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 28
[junit4] 2> 41097 T76 C30 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 41098 T76 C30 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_2,generation=2}
[junit4] 2> 41100 T76 C30 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 41101 T76 C30 oass.SolrIndexSearcher.<init> Opening Searcher@1b53254[collection1] main
[junit4] 2> 41101 T76 C30 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 41102 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1b53254[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 41103 T79 C30 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> 41106 T79 C30 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> 41111 T79 C30 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=4
[junit4] 2> 41111 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 41111 T79 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b53254[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 41112 T76 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> ASYNC NEW_CORE C31 name=collection1 org.apache.solr.core.SolrCore@53c66
[junit4] 2> 43026 T76 C31 oashdc.DIHConfiguration.verifyWithSchema id is a required field in SolrSchema . But not found in DataConfig
[junit4] 2> 43027 T76 C31 oashd.DataImporter.loadDataConfig Data Configuration loaded successfully
[junit4] 2> 43027 T76 C31 oashd.DataImporter.doFullImport Starting Full Import
[junit4] 2> 43031 T76 C31 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
[junit4] 2> 43032 T76 C31 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 43043 T76 C31 oashd.JdbcDataSource$1.call Creating a connection for entity FIRST with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 43045 T76 C31 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4] 2> ASYNC NEW_CORE C32 name=collection1 org.apache.solr.core.SolrCore@53c66
[junit4] 2> 43940 T76 C32 oashd.JdbcDataSource$1.call Creating a connection for entity SECOND with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 43943 T76 C32 oashd.JdbcDataSource$1.call Time taken for getConnection(): 1
[junit4] 2> 43976 T76 C32 oashd.JdbcDataSource$1.call Creating a connection for entity THIRD with URL: jdbc:derby:memory:derbyDB;territory=en_US
[junit4] 2> 43976 T76 C32 oashd.JdbcDataSource$1.call Time taken for getConnection(): 0
[junit4] 2> 43984 T76 C32 oashd.DocBuilder.finish Import completed successfully
[junit4] 2> 43986 T76 C32 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43988 T76 C32 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ff4e2a lockFactory=NativeFSLockFactory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index),segFN=segments_3,generation=3}
[junit4] 2> 43989 T76 C32 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 43990 T76 C32 oass.SolrIndexSearcher.<init> Opening Searcher@53ba81[collection1] main
[junit4] 2> 43992 T76 C32 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43992 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@53ba81[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
[junit4] 2> 43993 T79 C32 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> 43993 T79 C32 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> 43995 T79 C32 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=2
[junit4] 2> 43995 T79 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 43995 T79 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@53ba81[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
[junit4] 2> 43996 T76 C32 oashd.SimplePropertiesWriter.readIndexerProperties WARN Unable to read: dataimport.properties
[junit4] 2> 43997 T76 C32 oashd.SimplePropertiesWriter.persist Wrote last indexed time to dataimport.properties
[junit4] 2> 43997 T76 C32 oashd.DocBuilder.execute Time taken = 0:0:1.96
[junit4] 2> 43998 T76 C32 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 977
[junit4] 2> 44000 T76 C32 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4] 2> 44002 T76 C32 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> 44544 T76 oas.SolrTestCaseJ4.tearDown ###Ending test
[junit4] 2> 44620 T76 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 44620 T76 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=23558811
[junit4] 2> 44622 T76 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@53c66
[junit4] 2> 44623 T76 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> 44623 T76 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 44623 T76 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 44623 T76 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 44627 T76 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 44627 T76 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 44627 T76 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\;done=false>>]
[junit4] 2> 44627 T76 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\
[junit4] 2> 44627 T76 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index;done=false>>]
[junit4] 2> 44629 T76 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\.\temp\solr.handler.dataimport.TestNestedChildren-73B1D5EA76876E2F-001\init-core-data-001\index
[junit4] 2> 6404 T75 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 26549 T75 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1 thread leaked from SUITE scope at org.apache.solr.handler.dataimport.TestNestedChildren:
[junit4] 2> 1) Thread[id=77, 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> 26549 T75 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=77, name=Timer-0, state=WAITING, group=TGRP-TestNestedChildren]
[junit4] 2> 29552 T75 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=77, 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=Lucene41, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=sr__#Latn, timezone=America/Scoresbysund
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_20-ea (32-bit)/cpus=2,threads=2,free=3173952,total=28839936
[junit4] 2> NOTE: All tests run in this JVM: [TestContextImpl, TestSolrEntityProcessorUnit, TestContentStreamDataSource, TestEphemeralCache, TestClobTransformer, TestVariableResolver, TestEntityProcessorBase, TestDocBuilder2, TestFileListWithLineEntityProcessor, TestDocBuilder, TestJdbcDataSource, TestURLDataSource, TestFieldReader, TestBuiltInEvaluators, TestNestedChildren]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestNestedChildren -Dtests.seed=73B1D5EA76876E2F -Dtests.slow=true -Dtests.locale=sr__#Latn -Dtests.timezone=America/Scoresbysund -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s | 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=77, 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([73B1D5EA76876E2F]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=77, 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([73B1D5EA76876E2F]:0)
[junit4] Completed in 29.67s, 1 test, 2 errors <<< FAILURES!
[...truncated 72 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:454: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:209: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:440: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1307: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:922: There were test failures: 37 suites, 148 tests, 2 suite-level errors, 92 ignored
Total time: 169 minutes 16 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_20-ea-b23 -client -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any