Started by an SCM change Building in workspace /var/lib/jenkins/jobs/d1_cn_index_common/workspace Cleaning local Directory . Checking out https://repository.dataone.org/software/cicore/trunk/cn/d1_cn_index_common at revision '2018-09-07T21:04:33.024 +0000' A README AU LICENSE.txt A src A src/test A src/test/resources A src/test/resources/log4j.properties A src/test/resources/d1_testdocs A src/test/resources/d1_testdocs/peggym.127.1 A src/test/resources/d1_testdocs/peggym.127.1-sysmeta A src/test/resources/org A src/test/resources/org/dataone A src/test/resources/org/dataone/cn A src/test/resources/org/dataone/cn/index A src/test/resources/org/dataone/cn/index/test A src/test/resources/org/dataone/cn/index/test/test-context.xml A src/test/java A src/test/java/org A src/test/java/org/dataone A src/test/java/org/dataone/cn A src/test/java/org/dataone/cn/index A src/test/java/org/dataone/cn/index/messaging A src/test/java/org/dataone/cn/index/test A src/test/java/org/dataone/cn/index/test/IndexTaskJpaRepositoryTest.java A src/test/java/org/dataone/cn/index/test/IgnoringIndexIdPoolTest.java A src/main A src/main/resources A src/main/resources/org A src/main/resources/org/dataone A src/main/resources/org/dataone/configuration A src/main/resources/org/dataone/configuration/jdbc.properties A src/main/resources/org/dataone/configuration/postgres-datasource.xml A src/main/resources/org/dataone/configuration/hsql-datasource.xml A src/main/resources/task-index-context.xml A src/main/resources/buildInfo A src/main/resources/buildInfo/buildInfo.properties A src/main/java A src/main/java/org A src/main/java/org/dataone A src/main/java/org/dataone/cn A src/main/java/org/dataone/cn/index A src/main/java/org/dataone/cn/index/messaging A src/main/java/org/dataone/cn/index/messaging/rabbitmq A src/main/java/org/dataone/cn/index/util A src/main/java/org/dataone/cn/index/util/PerformanceLogger.java A src/main/java/org/dataone/cn/index/task A src/main/java/org/dataone/cn/index/task/IndexTask.java A src/main/java/org/dataone/cn/index/task/IndexTaskRepository.java A src/main/java/org/dataone/cn/index/task/IgnoringIndexIdPool.java A src/main/java/org/dataone/cn/index/task/IndexTaskGenerator.java A pom.xml U . At revision 19326 Parsing POMs Modules changed, recalculating dependency graph Established TCP socket on 43644 [workspace] $ java -cp /var/lib/jenkins/plugins/maven-plugin/WEB-INF/lib/maven3-agent-1.12-alpha-1.jar:/usr/share/maven/boot/plexus-classworlds-2.x.jar org.jvnet.hudson.maven3.agent.Maven3Main /usr/share/maven /var/cache/jenkins/war/WEB-INF/lib/remoting-3.20.jar /var/lib/jenkins/plugins/maven-plugin/WEB-INF/lib/maven3-interceptor-1.12-alpha-1.jar /var/lib/jenkins/plugins/maven-plugin/WEB-INF/lib/maven3-interceptor-commons-1.12-alpha-1.jar 43644 <===[JENKINS REMOTING CAPACITY]===>channel started Executing Maven: -B -f /var/lib/jenkins/jobs/d1_cn_index_common/workspace/pom.xml clean install javadoc:javadoc [INFO] Scanning for projects... [WARNING] [WARNING] Some problems were encountered while building the effective model for org.dataone:d1_cn_index_common:jar:2.4.0-SNAPSHOT [WARNING] 'build.plugins.plugin.version' for org.apache.maven.plugins:maven-compiler-plugin is missing. @ line 133, column 21 [WARNING] 'build.plugins.plugin.version' for org.apache.maven.plugins:maven-jar-plugin is missing. @ line 157, column 21 [WARNING] 'build.plugins.plugin.version' for org.codehaus.mojo:buildnumber-maven-plugin is missing. @ line 141, column 21 [WARNING] [WARNING] It is highly recommended to fix these problems because they threaten the stability of your build. [WARNING] [WARNING] For this reason, future Maven versions might no longer support building such malformed projects. [WARNING] [INFO] [INFO] ------------------------------------------------------------------------ [INFO] Building DataONE Index Common 2.4.0-SNAPSHOT [INFO] ------------------------------------------------------------------------ Downloading: http://maven.dataone.org/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.pom (4 KB at 10.7 KB/sec) Downloading: http://maven.dataone.org/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.pom (5 KB at 42.8 KB/sec) Downloading: http://maven.dataone.org/org/jboss/jboss-parent/9/jboss-parent-9.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/9/jboss-parent-9.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/9/jboss-parent-9.pom (28 KB at 176.5 KB/sec) Downloading: http://maven.dataone.org/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.pom (2 KB at 16.6 KB/sec) Downloading: http://maven.dataone.org/org/jboss/logging/jboss-logging-tools-parent/1.2.0.Beta1/jboss-logging-tools-parent-1.2.0.Beta1.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-tools-parent/1.2.0.Beta1/jboss-logging-tools-parent-1.2.0.Beta1.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-tools-parent/1.2.0.Beta1/jboss-logging-tools-parent-1.2.0.Beta1.pom (4 KB at 31.7 KB/sec) Downloading: http://maven.dataone.org/org/jboss/jboss-parent/10/jboss-parent-10.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/10/jboss-parent-10.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/10/jboss-parent-10.pom (30 KB at 185.9 KB/sec) Downloading: http://maven.dataone.org/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.pom (4 KB at 28.9 KB/sec) Downloading: http://maven.dataone.org/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.pom (5 KB at 38.8 KB/sec) Downloading: http://maven.dataone.org/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.pom (3 KB at 16.8 KB/sec) Downloading: http://maven.dataone.org/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.pom (3 KB at 17.4 KB/sec) Downloading: http://maven.dataone.org/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.pom Downloading: http://repo.maven.apache.org/maven2/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.pom Downloaded: http://repo.maven.apache.org/maven2/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.pom (10 KB at 81.6 KB/sec) Downloading: http://maven.dataone.org/antlr/antlr/2.7.7/antlr-2.7.7.pom Downloading: http://repo.maven.apache.org/maven2/antlr/antlr/2.7.7/antlr-2.7.7.pom Downloaded: http://repo.maven.apache.org/maven2/antlr/antlr/2.7.7/antlr-2.7.7.pom (632 B at 5.6 KB/sec) Downloading: http://maven.dataone.org/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.pom (3 KB at 20.2 KB/sec) Downloading: http://maven.dataone.org/org/jboss/jboss-parent/5/jboss-parent-5.pom Downloading: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/5/jboss-parent-5.pom Downloaded: http://repo.maven.apache.org/maven2/org/jboss/jboss-parent/5/jboss-parent-5.pom (19 KB at 121.5 KB/sec) Downloading: http://maven.dataone.org/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.jar Downloading: http://maven.dataone.org/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.jar Downloading: http://maven.dataone.org/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.jar Downloading: http://maven.dataone.org/antlr/antlr/2.7.7/antlr-2.7.7.jar Downloading: http://maven.dataone.org/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.jar Downloading: http://maven.dataone.org/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.jar Downloading: http://maven.dataone.org/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.jar Downloading: http://maven.dataone.org/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.jar Downloading: http://maven.dataone.org/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.jar Downloading: http://maven.dataone.org/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.jar Downloading: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.jar Downloading: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.jar Downloading: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.jar Downloading: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.jar Downloading: http://repo.maven.apache.org/maven2/antlr/antlr/2.7.7/antlr-2.7.7.jar Downloaded: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging-annotations/1.2.0.Beta1/jboss-logging-annotations-1.2.0.Beta1.jar (12 KB at 84.9 KB/sec) Downloading: http://repo.maven.apache.org/maven2/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.jar Downloaded: http://repo.maven.apache.org/maven2/org/jboss/logging/jboss-logging/3.1.3.GA/jboss-logging-3.1.3.GA.jar (56 KB at 206.8 KB/sec) Downloading: http://repo.maven.apache.org/maven2/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.jar Downloaded: http://repo.maven.apache.org/maven2/org/jboss/jandex/1.1.0.Final/jandex-1.1.0.Final.jar (75 KB at 302.7 KB/sec) Downloading: http://repo.maven.apache.org/maven2/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.jar Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/common/hibernate-commons-annotations/4.0.5.Final/hibernate-commons-annotations-4.0.5.Final.jar (74 KB at 300.2 KB/sec) Downloading: http://repo.maven.apache.org/maven2/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.jar Downloaded: http://repo.maven.apache.org/maven2/org/jboss/spec/javax/transaction/jboss-transaction-api_1.2_spec/1.0.0.Final/jboss-transaction-api_1.2_spec-1.0.0.Final.jar (28 KB at 233.3 KB/sec) Downloading: http://repo.maven.apache.org/maven2/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.jar Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/javax/persistence/hibernate-jpa-2.1-api/1.0.0.Final/hibernate-jpa-2.1-api-1.0.0.Final.jar (111 KB at 301.7 KB/sec) Downloaded: http://repo.maven.apache.org/maven2/antlr/antlr/2.7.7/antlr-2.7.7.jar (435 KB at 446.0 KB/sec) Downloaded: http://repo.maven.apache.org/maven2/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.jar (698 KB at 1270.4 KB/sec) Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-entitymanager/4.3.11.Final/hibernate-entitymanager-4.3.11.Final.jar (633 KB at 428.8 KB/sec) Downloaded: http://repo.maven.apache.org/maven2/org/hibernate/hibernate-core/4.3.11.Final/hibernate-core-4.3.11.Final.jar (5160 KB at 733.9 KB/sec) [INFO] [INFO] --- maven-clean-plugin:2.3:clean (default-clean) @ d1_cn_index_common --- [INFO] [INFO] --- buildnumber-maven-plugin:1.4:create (default) @ d1_cn_index_common --- [INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_index_common/workspace' && 'svn' '--non-interactive' 'info' [INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_index_common/workspace [INFO] Storing buildNumber: 19326 at timestamp: 1536354288981 [INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_index_common/workspace' && 'svn' '--non-interactive' 'info' [INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_index_common/workspace [INFO] Storing buildScmBranch: trunk [INFO] [INFO] --- maven-resources-plugin:2.3:resources (default-resources) @ d1_cn_index_common --- [INFO] Using 'UTF-8' encoding to copy filtered resources. [INFO] Copying 1 resource [INFO] Copying 5 resources [INFO] [INFO] --- maven-compiler-plugin:2.0.2:compile (default-compile) @ d1_cn_index_common --- [INFO] Compiling 5 source files to /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/classes [INFO] [INFO] --- maven-resources-plugin:2.3:testResources (default-testResources) @ d1_cn_index_common --- [INFO] Using 'UTF-8' encoding to copy filtered resources. [INFO] Copying 4 resources [INFO] [INFO] --- maven-compiler-plugin:2.0.2:testCompile (default-testCompile) @ d1_cn_index_common --- [INFO] Compiling 2 source files to /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/test-classes [INFO] [INFO] --- maven-surefire-plugin:2.10:test (default-test) @ d1_cn_index_common --- [INFO] Surefire report directory: /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/surefire-reports ------------------------------------------------------- T E S T S ------------------------------------------------------- Running org.dataone.cn.index.test.IndexTaskJpaRepositoryTest 2018-09-07 21:04:51,088 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] - Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener] 2018-09-07 21:04:51,099 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] - Could not instantiate TestExecutionListener [org.springframework.test.context.web.ServletTestExecutionListener]. Specify custom listener classes or make the default listener classes (and their required dependencies) available. Offending class: [javax/servlet/ServletContext] 2018-09-07 21:04:51,099 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] - Using TestExecutionListeners: [org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@78e67e0a, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@bd8db5a, org.springframework.test.context.support.DirtiesContextTestExecutionListener@2f943d71, org.springframework.test.context.transaction.TransactionalTestExecutionListener@80503, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@4b553d26] 2018-09-07 21:04:51,157 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from class path resource [org/dataone/cn/index/test/test-context.xml] 2018-09-07 21:04:51,270 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from class path resource [task-index-context.xml] 2018-09-07 21:04:51,377 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from class path resource [org/dataone/configuration/postgres-datasource.xml] 2018-09-07 21:04:51,424 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from class path resource [org/dataone/configuration/hsql-datasource.xml] 2018-09-07 21:04:51,436 INFO [org.springframework.beans.factory.support.DefaultListableBeanFactory] - Overriding bean definition for bean 'jpaVendorAdapter' with a different definition: replacing [Generic bean: class [org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in class path resource [org/dataone/configuration/postgres-datasource.xml]] with [Generic bean: class [org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in class path resource [org/dataone/configuration/hsql-datasource.xml]] 2018-09-07 21:04:51,439 INFO [org.springframework.beans.factory.support.DefaultListableBeanFactory] - Overriding bean definition for bean 'dataSource' with a different definition: replacing [Generic bean: class [org.apache.commons.dbcp.BasicDataSource]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=close; defined in class path resource [org/dataone/configuration/postgres-datasource.xml]] with [Root bean: class [org.springframework.jdbc.datasource.embedded.EmbeddedDatabaseFactoryBean]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null] 2018-09-07 21:04:51,441 INFO [org.springframework.context.support.GenericApplicationContext] - Refreshing org.springframework.context.support.GenericApplicationContext@612679d6: startup date [Fri Sep 07 21:04:51 UTC 2018]; root of context hierarchy 2018-09-07 21:04:51,602 INFO [org.springframework.jdbc.datasource.embedded.EmbeddedDatabaseFactory] - Starting embedded database: url='jdbc:h2:mem:dataSource;DB_CLOSE_DELAY=-1;DB_CLOSE_ON_EXIT=false', username='sa' 2018-09-07 21:04:51,647 INFO [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] - Building JPA container EntityManagerFactory for persistence unit 'default' 2018-09-07 21:04:51,663 INFO [org.hibernate.jpa.internal.util.LogHelper] - HHH000204: Processing PersistenceUnitInfo [ name: default ...] 2018-09-07 21:04:51,710 INFO [org.hibernate.Version] - HHH000412: Hibernate Core {4.3.11.Final} 2018-09-07 21:04:51,711 INFO [org.hibernate.cfg.Environment] - HHH000206: hibernate.properties not found 2018-09-07 21:04:51,712 INFO [org.hibernate.cfg.Environment] - HHH000021: Bytecode provider name : javassist 2018-09-07 21:04:51,856 INFO [org.hibernate.annotations.common.Version] - HCANN000001: Hibernate Commons Annotations {4.0.5.Final} 2018-09-07 21:04:52,043 INFO [org.hibernate.dialect.Dialect] - HHH000400: Using dialect: org.hibernate.dialect.H2Dialect 2018-09-07 21:04:52,053 INFO [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] - HHH000423: Disabling contextual LOB creation as JDBC driver reported JDBC version [3] less than 4 2018-09-07 21:04:52,171 INFO [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] - HHH000397: Using ASTQueryTranslatorFactory 2018-09-07 21:04:52,342 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] - HHH000228: Running hbm2ddl schema update 2018-09-07 21:04:52,342 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] - HHH000102: Fetching database metadata 2018-09-07 21:04:52,343 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] - HHH000396: Updating schema 2018-09-07 21:04:52,346 INFO [java.sql.DatabaseMetaData] - HHH000262: Table not found: index_task 2018-09-07 21:04:52,347 INFO [java.sql.DatabaseMetaData] - HHH000262: Table not found: index_task 2018-09-07 21:04:52,347 INFO [java.sql.DatabaseMetaData] - HHH000262: Table not found: index_task 2018-09-07 21:04:52,775 INFO [org.hibernate.tool.hbm2ddl.SchemaUpdate] - HHH000232: Schema update complete 2018-09-07 21:04:52,805 INFO [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] - Initialized JPA EntityManagerFactory for persistence unit 'default' Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,273 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testTaskExecutionBackoffForFailed(IndexTaskJpaRepositoryTest.java:130) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:3e43ac42-7c55-4791-90e6-0137f5befe59' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:3e43ac42-7c55-4791-90e6-0137f5befe59' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? order by indextask0_.priority asc, indextask0_.taskModifiedDate asc Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? 2018-09-07 21:04:53,392 INFO [org.dataone.cn.index.test.IndexTaskJpaRepositoryTest] - ******* Stale Object Detected (as expected)! 2018-09-07 21:04:53,394 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:340) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'garbage taskc7903be8-5fdc-474f-9ad4-1c5bbdf27530' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'garbage taskc7903be8-5fdc-474f-9ad4-1c5bbdf27530' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? 2018-09-07 21:04:53,404 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:350) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '1st created task: f7f29768-71c4-4939-8aaa-de9af5e7bff9' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '1st created task: f7f29768-71c4-4939-8aaa-de9af5e7bff9' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,409 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:354) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '2nd created task: f80f0f90-12ac-4c0f-ba17-adbb262df63b' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '2nd created task: f80f0f90-12ac-4c0f-ba17-adbb262df63b' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,412 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:358) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '3rd created task: 00a859c7-d849-41bc-aa76-3c0ad5ab1a55' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '3rd created task: 00a859c7-d849-41bc-aa76-3c0ad5ab1a55' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,418 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:361) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '4th created task: 2bb2a07b-ec56-4b86-a6d9-7813bf48149d' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value '4th created task: 2bb2a07b-ec56-4b86-a6d9-7813bf48149d' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,424 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindIndexTaskQueue(IndexTaskJpaRepositoryTest.java:364) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'thrd created task: 603f60ff-6720-4de3-80f4-dd846a77022a' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 40 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'thrd created task: 603f60ff-6720-4de3-80f4-dd846a77022a' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 43 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? order by indextask0_.priority asc, indextask0_.taskModifiedDate asc 2018-09-07 21:04:53,430 INFO [org.dataone.cn.index.test.IndexTaskJpaRepositoryTest] - First queue task: 3rd created task: 00a859c7-d849-41bc-aa76-3c0ad5ab1a55 priority: 1 task build time: 09/07/2018:21:04:53:413 2018-09-07 21:04:53,430 INFO [org.dataone.cn.index.test.IndexTaskJpaRepositoryTest] - Second queue task: 1st created task: f7f29768-71c4-4939-8aaa-de9af5e7bff9 priority: 2 task build time: 09/07/2018:21:04:53:406 2018-09-07 21:04:53,430 INFO [org.dataone.cn.index.test.IndexTaskJpaRepositoryTest] - Second queue task: 2nd created task: f80f0f90-12ac-4c0f-ba17-adbb262df63b priority: 2 task build time: 09/07/2018:21:04:53:410 Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? 2018-09-07 21:04:53,452 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTask(IndexTaskJpaRepositoryTest.java:438) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindByPidQuery(IndexTaskJpaRepositoryTest.java:286) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:af136cdb-7917-4413-b96d-b52b8d383e3f' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 42 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:af136cdb-7917-4413-b96d-b52b8d383e3f' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 45 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.pid=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: delete from index_task where id=? and version=? Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: select count(*) as col_0_0_ from index_task indextask0_ where indextask0_.id=? and 1=1 Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: delete from index_task where id=? and version=? Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,494 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testTaskExecutionBackoffForRetry(IndexTaskJpaRepositoryTest.java:75) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:9e75a429-0d34-487e-84e9-784400053e0d' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:9e75a429-0d34-487e-84e9-784400053e0d' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? order by indextask0_.priority asc, indextask0_.taskModifiedDate asc Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,503 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,508 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,513 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,518 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,522 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,526 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,530 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,534 INFO [org.dataone.cn.index.task.IndexTask] - Even tough it was masked new, it is still considered failed for id find by pid:9e75a429-0d34-487e-84e9-784400053e0d since it was tried to many times. Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,541 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindByStatusAndNextExection(IndexTaskJpaRepositoryTest.java:316) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:c65de632-04ed-4afb-a453-fa4cfc73a8e0' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:c65de632-04ed-4afb-a453-fa4cfc73a8e0' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,544 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindByStatusAndNextExection(IndexTaskJpaRepositoryTest.java:319) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:ff31048c-5f3e-4887-bfca-fc6549a374d8' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:ff31048c-5f3e-4887-bfca-fc6549a374d8' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_0_, indextask0_.dateSysMetaModified as dateSysM2_0_0_, indextask0_.deleted as deleted3_0_0_, indextask0_.formatId as formatId4_0_0_, indextask0_.nextExecution as nextExec5_0_0_, indextask0_.objectPath as objectPa6_0_0_, indextask0_.pid as pid7_0_0_, indextask0_.priority as priority8_0_0_, indextask0_.status as status9_0_0_, indextask0_.sysMetadata as sysMeta10_0_0_, indextask0_.taskModifiedDate as taskMod11_0_0_, indextask0_.tryCount as tryCoun12_0_0_, indextask0_.version as version13_0_0_ from index_task indextask0_ where indextask0_.id=? Hibernate: update index_task set dateSysMetaModified=?, deleted=?, formatId=?, nextExecution=?, objectPath=?, pid=?, priority=?, status=?, sysMetadata=?, taskModifiedDate=?, tryCount=?, version=? where id=? and version=? Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.status=? and indextask0_.nextExecution<? 2018-09-07 21:04:53,551 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindByPidAndStatusQuery(IndexTaskJpaRepositoryTest.java:298) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:726aaaad-d795-4529-ac64-049f6db21589' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:726aaaad-d795-4529-ac64-049f6db21589' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) 2018-09-07 21:04:53,553 ERROR [org.dataone.cn.index.task.IndexTask] - org.dataone.exceptions.MarshallingException at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:232) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:202) at org.dataone.cn.index.task.IndexTask.marshalSystemMetadata(IndexTask.java:232) at org.dataone.cn.index.task.IndexTask.<init>(IndexTask.java:203) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatusAndPriority(IndexTaskJpaRepositoryTest.java:446) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.saveIndexTaskWithStatus(IndexTaskJpaRepositoryTest.java:442) at org.dataone.cn.index.test.IndexTaskJpaRepositoryTest.testFindByPidAndStatusQuery(IndexTaskJpaRepositoryTest.java:302) 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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:252) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:94) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:191) at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:104) 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 org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110) at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175) at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68) Caused by: javax.xml.bind.MarshalException - with linked exception: [org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:83bcb627-6086-4fa8-9673-3ad4f4e4f55f' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'.] at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:311) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.marshal(MarshallerImpl.java:236) at javax.xml.bind.helpers.AbstractMarshallerImpl.marshal(AbstractMarshallerImpl.java:95) at org.dataone.service.util.TypeMarshaller.marshalTypeToOutputStream(TypeMarshaller.java:229) ... 41 more Caused by: org.xml.sax.SAXParseException; lineNumber: 0; columnNumber: 0; cvc-pattern-valid: Value 'find by pid:83bcb627-6086-4fa8-9673-3ad4f4e4f55f' is not facet-valid with respect to pattern '\S+' for type 'NonEmptyNoWhitespaceString800'. at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203) at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327) at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator$XSIErrorReporter.reportError(XMLSchemaValidator.java:452) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.reportSchemaError(XMLSchemaValidator.java:3230) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidComplexType(XMLSchemaValidator.java:3184) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.elementLocallyValidType(XMLSchemaValidator.java:3153) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.processElementContent(XMLSchemaValidator.java:3055) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.handleEndElement(XMLSchemaValidator.java:2134) at com.sun.org.apache.xerces.internal.impl.xs.XMLSchemaValidator.endElement(XMLSchemaValidator.java:853) at com.sun.org.apache.xerces.internal.jaxp.validation.ValidatorHandlerImpl.endElement(ValidatorHandlerImpl.java:584) at org.xml.sax.helpers.XMLFilterImpl.endElement(XMLFilterImpl.java:570) at com.sun.xml.internal.bind.v2.runtime.output.SAXOutput.endTag(SAXOutput.java:117) at com.sun.xml.internal.bind.v2.runtime.output.XmlOutputAbstractImpl.endTag(XmlOutputAbstractImpl.java:109) at com.sun.xml.internal.bind.v2.runtime.output.ForkXmlOutput.endTag(ForkXmlOutput.java:76) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.leafElement(XMLSerializer.java:317) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1036) at com.sun.xml.internal.bind.v2.model.impl.RuntimeBuiltinLeafInfoImpl$StringImplImpl.writeLeafElement(RuntimeBuiltinLeafInfoImpl.java:1015) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:396) at com.sun.xml.internal.bind.v2.runtime.reflect.TransducedAccessor$CompositeTransducedAccessorImpl.writeLeafElement(TransducedAccessor.java:239) at com.sun.xml.internal.bind.v2.runtime.property.SingleElementLeafProperty.serializeBody(SingleElementLeafProperty.java:115) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:345) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:336) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsSoleContent(XMLSerializer.java:578) at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeRoot(ClassBeanInfoImpl.java:326) at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.childAsRoot(XMLSerializer.java:479) at com.sun.xml.internal.bind.v2.runtime.MarshallerImpl.write(MarshallerImpl.java:308) ... 44 more Hibernate: insert into index_task (id, dateSysMetaModified, deleted, formatId, nextExecution, objectPath, pid, priority, status, sysMetadata, taskModifiedDate, tryCount, version) values (null, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) Hibernate: select indextask0_.id as id1_0_, indextask0_.dateSysMetaModified as dateSysM2_0_, indextask0_.deleted as deleted3_0_, indextask0_.formatId as formatId4_0_, indextask0_.nextExecution as nextExec5_0_, indextask0_.objectPath as objectPa6_0_, indextask0_.pid as pid7_0_, indextask0_.priority as priority8_0_, indextask0_.status as status9_0_, indextask0_.sysMetadata as sysMeta10_0_, indextask0_.taskModifiedDate as taskMod11_0_, indextask0_.tryCount as tryCoun12_0_, indextask0_.version as version13_0_ from index_task indextask0_ where indextask0_.pid=? and indextask0_.status=? Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.663 sec Running org.dataone.cn.index.test.IgnoringIndexIdPoolTest Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec 2018-09-07 21:04:53,563 INFO [org.springframework.context.support.GenericApplicationContext] - Closing org.springframework.context.support.GenericApplicationContext@612679d6: startup date [Fri Sep 07 21:04:51 UTC 2018]; root of context hierarchy 2018-09-07 21:04:53,564 INFO [org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] - Closing JPA EntityManagerFactory for persistence unit 'default' 2018-09-07 21:04:53,564 INFO [org.springframework.jdbc.datasource.embedded.EmbeddedDatabaseFactory] - Shutting down embedded database: url='jdbc:h2:mem:dataSource;DB_CLOSE_DELAY=-1;DB_CLOSE_ON_EXIT=false' Results : Tests run: 13, Failures: 0, Errors: 0, Skipped: 0 [JENKINS] Recording test results [WARNING] Attempt to (de-)serialize anonymous class hudson.maven.reporters.SurefireArchiver$2; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/ [WARNING] Attempt to (de-)serialize anonymous class hudson.maven.reporters.BuildInfoRecorder$1; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/ [INFO] [INFO] --- maven-jar-plugin:2.2:jar (default-jar) @ d1_cn_index_common --- [INFO] Building jar: /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/d1_cn_index_common-2.4.0-SNAPSHOT.jar [INFO] [INFO] --- maven-install-plugin:2.3:install (default-install) @ d1_cn_index_common --- [INFO] Installing /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/d1_cn_index_common-2.4.0-SNAPSHOT.jar to /var/lib/jenkins/.m2/repository/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-SNAPSHOT.jar [INFO] Installing /var/lib/jenkins/jobs/d1_cn_index_common/workspace/pom.xml to /var/lib/jenkins/.m2/repository/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-SNAPSHOT.pom [INFO] [INFO] --- buildnumber-maven-plugin:1.4:create (default) @ d1_cn_index_common --- [INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_index_common/workspace' && 'svn' '--non-interactive' 'info' [INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_index_common/workspace [INFO] Storing buildNumber: 19326 at timestamp: 1536354295760 [INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_index_common/workspace' && 'svn' '--non-interactive' 'info' [INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_index_common/workspace [INFO] Storing buildScmBranch: trunk [WARNING] Failed to getClass for org.apache.maven.plugin.javadoc.JavadocReport [INFO] [INFO] --- maven-javadoc-plugin:2.10.4:javadoc (default-cli) @ d1_cn_index_common --- [INFO] Loading source files for package org.dataone.cn.index.util... Loading source files for package org.dataone.cn.index.task... Constructing Javadoc information... Standard Doclet version 1.8.0_111 Building tree for all the packages and classes... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/PerformanceLogger.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/IgnoringIndexIdPool.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/IndexTask.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/IndexTaskGenerator.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/IndexTaskRepository.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/overview-frame.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/package-frame.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/package-summary.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/package-tree.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/package-frame.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/package-summary.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/package-tree.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/constant-values.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/serialized-form.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/class-use/PerformanceLogger.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/class-use/IndexTaskGenerator.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/class-use/IgnoringIndexIdPool.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/class-use/IndexTaskRepository.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/class-use/IndexTask.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/task/package-use.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/org/dataone/cn/index/util/package-use.html... Building index for all the packages and classes... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/overview-tree.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/index-all.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/deprecated-list.html... Building index for all classes... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/allclasses-frame.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/allclasses-noframe.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/index.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/overview-summary.html... Generating /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/site/apidocs/help-doc.html... 8 warnings [WARNING] Javadoc Warnings [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTask.java:266: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTask.java:348: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTask.java:358: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTask.java:358: warning - @return tag cannot be used in method with void return type. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTaskGenerator.java:86: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTaskRepository.java:47: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTaskRepository.java:58: warning - @return tag has no arguments. [WARNING] /var/lib/jenkins/jobs/d1_cn_index_common/workspace/src/main/java/org/dataone/cn/index/task/IndexTaskRepository.java:67: warning - @return tag has no arguments. [JENKINS] Archiving javadoc [WARNING] Attempt to (de-)serialize anonymous class hudson.FilePath$32; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/ [WARNING] Attempt to (de-)serialize anonymous class hudson.maven.reporters.MavenArtifactArchiver$2; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/ [WARNING] Attempt to (de-)serialize anonymous class hudson.maven.reporters.MavenFingerprinter$1; see: https://jenkins.io/redirect/serialization-of-anonymous-classes/ Notifying upstream projects of job completion Join notifier requires a CauseAction [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 18.864s [INFO] Finished at: Fri Sep 07 21:04:57 UTC 2018 [INFO] Final Memory: 43M/395M [INFO] ------------------------------------------------------------------------ Waiting for Jenkins to finish collecting data [JENKINS] Archiving /var/lib/jenkins/jobs/d1_cn_index_common/workspace/pom.xml to org.dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-SNAPSHOT.pom [JENKINS] Archiving /var/lib/jenkins/jobs/d1_cn_index_common/workspace/target/d1_cn_index_common-2.4.0-SNAPSHOT.jar to org.dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-SNAPSHOT.jar channel stopped Maven RedeployPublisher use remote maven settings from : /usr/share/maven/conf/settings.xml [ERROR] uniqueVersion == false is not anymore supported in maven 3 [INFO] Deployment in file:///var/www/maven (id=,uniqueVersion=false) Deploying the main artifact d1_cn_index_common-2.4.0-SNAPSHOT.jar Downloading: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/maven-metadata.xml Downloaded: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/maven-metadata.xml (782 B at 763.7 KB/sec) Uploading: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-20180907.210458-12.jar Uploaded: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-20180907.210458-12.jar (15 KB at 14839.8 KB/sec) Uploading: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-20180907.210458-12.pom Uploaded: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/d1_cn_index_common-2.4.0-20180907.210458-12.pom (8 KB) Downloading: file:///var/www/maven/org/dataone/d1_cn_index_common/maven-metadata.xml Downloaded: file:///var/www/maven/org/dataone/d1_cn_index_common/maven-metadata.xml (2 KB at 1479.5 KB/sec) Uploading: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/maven-metadata.xml Uploaded: file:///var/www/maven/org/dataone/d1_cn_index_common/2.4.0-SNAPSHOT/maven-metadata.xml (782 B) Uploading: file:///var/www/maven/org/dataone/d1_cn_index_common/maven-metadata.xml Uploaded: file:///var/www/maven/org/dataone/d1_cn_index_common/maven-metadata.xml (2 KB) [INFO] Deployment done in 46 ms Notifying upstream projects of job completion Not triggering d1_cn_index_tool because it has dependencies in the downstream project list Not triggering d1_cn_index_processor because it has dependencies in the downstream project list Not triggering d1_cn_index_generator because it has dependencies in the downstream project list Finished: SUCCESS