Failed

org.dataone.cn.indexer.annotation.SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation

Failing for the past 2 builds (Since Unstable#591 )
Took 0.77 sec.

Error Message

Unexpected exception from solr update!

Stacktrace

java.io.IOException: Unexpected exception from solr update!
	at org.dataone.cn.indexer.annotation.SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation(SolrIndexEmlAnnotationTest.java:51)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://localhost:8983/solr/collection1: Invalid Date in Date Math String:'元-07-31T12:59:47.000Z'
	at org.dataone.cn.indexer.annotation.SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation(SolrIndexEmlAnnotationTest.java:51)

Standard Error

Creating dataDir: /tmp/org.dataone.cn.indexer.annotation.SolrIndexEmlAnnotationTest_BA584B7172677722-001/init-core-data-001
[ INFO] 2019-11-11 06:48:39,529 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.solrhttp.SolrSchema:loadSolrSchemaDocument:298) loading schema document from path: ./src/test/resources/org/dataone/cn/index/resources/solr5home/collection1/conf/schema.xml
[ WARN] 2019-11-11 06:48:39,625 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.index.processor.IndexTaskProcessor:<init>:162) IndexTaskProcessor initialized with stated number of threads = 5
[ WARN] 2019-11-11 06:48:39,656 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.apache.solr.core.SolrResourceLoader:addToClassLoader:191) Can't find (or read) directory to add to classloader: lib (resolved as: /var/lib/jenkins/jobs/d1_cn_index_processor/workspace/./src/test/resources/org/dataone/cn/index/resources/solr5home/lib).
[ WARN] 2019-11-11 06:48:39,883 [coreLoadExecutor-15-thread-1]  (org.apache.solr.schema.AbstractSpatialFieldType:init:128) units parameter is deprecated, please use distanceUnits instead for field types with class SpatialRecursivePrefixTreeFieldType
[ WARN] 2019-11-11 06:48:39,884 [coreLoadExecutor-15-thread-1]  (org.apache.solr.schema.AbstractSpatialFieldType:init:128) units parameter is deprecated, please use distanceUnits instead for field types with class BBoxField
[ WARN] 2019-11-11 06:48:39,903 [coreLoadExecutor-15-thread-1]  (org.apache.solr.core.SolrCore:initIndex:541) [collection1] Solr index directory '/var/lib/jenkins/jobs/d1_cn_index_processor/workspace/./src/test/resources/org/dataone/cn/index/resources/solr5home/collection1/data/index' doesn't exist. Creating new index...
[ WARN] 2019-11-11 06:48:39,917 [coreLoadExecutor-15-thread-1]  (org.apache.solr.rest.ManagedResource:reloadFromStorage:182) No stored data found for /schema/analysis/synonyms/english
[ INFO] 2019-11-11 06:48:39,942 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:78) number of documents from parseDocuments: 1
[ INFO] 2019-11-11 06:48:39,942 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:94)  main document from parseDocuments: org.dataone.cn.indexer.solrhttp.SolrDoc@257f0921
[ INFO] 2019-11-11 06:48:39,942 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:96)  main document id from parseDocuments: eml-test-doc
[ INFO] 2019-11-11 06:48:39,947 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:78) number of documents from parseDocuments: 1
[ INFO] 2019-11-11 06:48:39,947 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:94)  main document from parseDocuments: org.dataone.cn.indexer.solrhttp.SolrDoc@53453606
[ INFO] 2019-11-11 06:48:39,947 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:96)  main document id from parseDocuments: null
[ INFO] 2019-11-11 06:48:39,951 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:78) number of documents from parseDocuments: 1
[ INFO] 2019-11-11 06:48:39,951 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:94)  main document from parseDocuments: org.dataone.cn.indexer.solrhttp.SolrDoc@3aad9415
[ INFO] 2019-11-11 06:48:39,951 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.AbstractStubMergingSubprocessor:processDocument:96)  main document id from parseDocuments: null
[ INFO] 2019-11-11 06:48:39,951 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.SolrIndexServiceV2:sendCommand:445) sendCommand using partial update?: false
[ERROR] 2019-11-11 06:48:39,960 [qtp276375282-78]  (org.apache.solr.common.SolrException:log:139) org.apache.solr.common.SolrException: Invalid Date in Date Math String:'元-07-31T12:59:47.000Z'
	at org.apache.solr.schema.TrieDateField.parseMath(TrieDateField.java:146)
	at org.apache.solr.schema.TrieField.createField(TrieField.java:655)
	at org.apache.solr.schema.TrieField.createFields(TrieField.java:694)
	at org.apache.solr.update.DocumentBuilder.addField(DocumentBuilder.java:48)
	at org.apache.solr.update.DocumentBuilder.toDocument(DocumentBuilder.java:123)
	at org.apache.solr.update.AddUpdateCommand.getLuceneDocument(AddUpdateCommand.java:83)
	at org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:237)
	at org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:163)
	at org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69)
	at org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51)
	at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:955)
	at org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1110)
	at org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:706)
	at org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250)
	at org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177)
	at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
	at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2064)
	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:654)
	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:450)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:227)
	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:196)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
	at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
	at org.eclipse.jetty.server.Server.handle(Server.java:497)
	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
	at java.lang.Thread.run(Thread.java:748)
Caused by: java.text.ParseException: Unparseable date: "元-07-31T12:59:47.000Z"
	at java.text.DateFormat.parse(DateFormat.java:366)
	at org.apache.solr.schema.TrieDateField.parseDate(TrieDateField.java:194)
	at org.apache.solr.schema.TrieDateField.parseMath(TrieDateField.java:144)
	... 43 more

[ WARN] 2019-11-11 06:48:39,962 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.solrhttp.SolrJClient:sendUpdateWithRedo:352) not all objects processed...
[ERROR] 2019-11-11 06:48:39,962 [TEST-SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation-seed#[BA584B7172677722]]  (org.dataone.cn.indexer.solrhttp.SolrJClient:sendUpdateWithRedo:356) exception updating solr from SolrClient
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://localhost:8983/solr/collection1: Invalid Date in Date Math String:'元-07-31T12:59:47.000Z'
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
	at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:107)
	at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:124)
	at org.dataone.cn.indexer.solrhttp.SolrJClient.sendUpdateWithRedo(SolrJClient.java:343)
	at org.dataone.cn.indexer.solrhttp.SolrJClient.sendUpdate(SolrJClient.java:188)
	at org.dataone.cn.indexer.SolrIndexServiceV2.sendCommand(SolrIndexServiceV2.java:446)
	at org.dataone.cn.indexer.SolrIndexServiceV2.insertIntoIndex(SolrIndexServiceV2.java:248)
	at org.dataone.cn.index.DataONESolrJettyTestBase.addSysAndSciMetaToSolrIndex(DataONESolrJettyTestBase.java:93)
	at org.dataone.cn.indexer.annotation.SolrIndexEmlAnnotationTest.testSystemMetadataEml220AndAnnotation(SolrIndexEmlAnnotationTest.java:51)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
	at java.lang.Thread.run(Thread.java:748)