Console Output
Skipping 363 KB..
Full Log.java:355)
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)
... 47 more
Caused by: com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:395)
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)
... 52 more
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
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.dao.SystemMetadataDaoMetacatImpl$SystemMetadataMapper.mapRow(SystemMetadataDaoMetacatImpl.java:1315)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl$SystemMetadataMapper.mapRow(SystemMetadataDaoMetacatImpl.java:1143)
at org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:93)
at org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:60)
at org.springframework.jdbc.core.JdbcTemplate$1.doInPreparedStatement(JdbcTemplate.java:697)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:633)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:684)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:711)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:761)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl.getSystemMetadata(SystemMetadataDaoMetacatImpl.java:309)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl.getSystemMetadata(SystemMetadataDaoMetacatImpl.java:127)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImplTest.testSimpleSaveSystemMetadata(SystemMetadataDaoMetacatImplTest.java:114)
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.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
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.junit.runners.ParentRunner.run(ParentRunner.java:363)
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:
[com.sun.istack.internal.SAXException2: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0]
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)
... 44 more
Caused by: com.sun.istack.internal.SAXException2: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:232)
at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:247)
at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:355)
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)
... 47 more
Caused by: com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:395)
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)
... 52 more
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
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.dao.SystemMetadataDaoMetacatImpl$SystemMetadataMapper.mapRow(SystemMetadataDaoMetacatImpl.java:1315)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl$SystemMetadataMapper.mapRow(SystemMetadataDaoMetacatImpl.java:1143)
at org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:93)
at org.springframework.jdbc.core.RowMapperResultSetExtractor.extractData(RowMapperResultSetExtractor.java:60)
at org.springframework.jdbc.core.JdbcTemplate$1.doInPreparedStatement(JdbcTemplate.java:697)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:633)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:684)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:711)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:761)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl.getSystemMetadata(SystemMetadataDaoMetacatImpl.java:309)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImpl.getSystemMetadata(SystemMetadataDaoMetacatImpl.java:127)
at org.dataone.cn.dao.SystemMetadataDaoMetacatImplTest.testSimpleSaveSystemMetadata(SystemMetadataDaoMetacatImplTest.java:114)
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.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
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.junit.runners.ParentRunner.run(ParentRunner.java:363)
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:
[com.sun.istack.internal.SAXException2: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0]
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)
... 44 more
Caused by: com.sun.istack.internal.SAXException2: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:232)
at com.sun.xml.internal.bind.v2.runtime.XMLSerializer.reportError(XMLSerializer.java:247)
at com.sun.xml.internal.bind.v2.runtime.ClassBeanInfoImpl.serializeBody(ClassBeanInfoImpl.java:355)
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)
... 47 more
Caused by: com.sun.xml.internal.bind.api.AccessorException: Object must have some value in its @XmlValue field: org.dataone.service.types.v1.ObjectFormatIdentifier@0
at com.sun.xml.internal.bind.v2.model.impl.RuntimeClassInfoImpl$TransducerImpl.writeLeafElement(RuntimeClassInfoImpl.java:395)
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)
... 52 more
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationpolicy;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS xml_access;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS systemmetadata;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS identifier;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS identifier ( guid text NOT NULL, docid character varying(250), rev bigint, CONSTRAINT identifier_pk PRIMARY KEY (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS systemmetadata ( guid text NOT NULL, series_id text, serial_version character varying(256), date_uploaded timestamp, rights_holder character varying(250), checksum character varying(512), checksum_algorithm character varying(250), origin_member_node character varying(250), authoritive_member_node character varying(250), date_modified timestamp, submitter character varying(256), object_format character varying(256), size character varying(256), archived boolean, replication_allowed boolean, number_replicas bigint, obsoletes text, obsoleted_by text, CONSTRAINT systemmetadata_pk PRIMARY KEY (guid));] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS xml_access ( guid text, accessfileid text, principal_name character varying(100), permission bigint, perm_type character varying(32), perm_order character varying(32), begin_time date, end_time date, ticket_count bigint, subtreeid character varying(32), startnodeid bigint, endnodeid bigint, CONSTRAINT xml_access_ck CHECK (begin_time < end_time)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationpolicy ( guid text, member_node character varying(250), policy text, CONSTRAINT smreplicationpolicy_fk FOREIGN KEY (guid) REFERENCES systemmetadata (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus ( guid text, member_node character varying(250), status character varying(250), date_verified timestamp, CONSTRAINT smreplicationstatus_fk FOREIGN KEY (guid) REFERENCES systemmetadata (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('891f20463b023bef25758cabee18b460.1.1', NULL, '1', '2013-08-01 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'c3450ab5803151f78e9e8f91f30f285a', 'MD5', '', '', '2013-08-01 10:17:42.117', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.1.0', '7482', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('6f632bd1cc2772bdcc43bafdbb9d8669.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '709eee7f02ff1f12a9084b906ee0770e', 'MD5', '', '', '2013-07-31 15:29:44.429', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14230', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('261585355b62129e038fabdacc1cd9fa.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eb0b66914142de3e6b2ed949f87096de', 'MD5', '', '', '2013-07-31 15:29:46.774', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14472', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco3-e2fab857d20b994edb1ad65069407423.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '14b343527abc4892fb3b7e50b0b4b096', 'MD5', '', '', '2013-07-31 17:39:09.264', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14514', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco3-f6fcf091959497c2a77967b732d0e631.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'de2c9e3c4a700e3816d4140b8319cce0', 'MD5', '', '', '2013-07-31 17:39:11.085', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '13424', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-6f632bd1cc2772bdcc43bafdbb9d8669.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '709eee7f02ff1f12a9084b906ee0770e', 'MD5', '', '', '2013-07-31 17:41:34.387', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14230', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-261585355b62129e038fabdacc1cd9fa.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eb0b66914142de3e6b2ed949f87096de', 'MD5', '', '', '2013-07-31 17:41:36.253', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14472', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-e2fab857d20b994edb1ad65069407423.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '14b343527abc4892fb3b7e50b0b4b096', 'MD5', '', '', '2013-07-31 17:41:38.243', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14514', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-f6fcf091959497c2a77967b732d0e631.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'de2c9e3c4a700e3816d4140b8319cce0', 'MD5', '', '', '2013-07-31 17:41:40.2', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '13424', false, false, -1, NULL, NULL); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-774d0eb40bb051046a5469be7d912d30.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '1842c6ce6c398afe62f15a01063b39a9', 'MD5', '', '', '2013-07-31 17:41:42.331', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '17211', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL query [SELECT count(guid) FROM systemmetadata] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationpolicy;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS xml_access;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS systemmetadata;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS identifier;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS identifier ( guid text NOT NULL, docid character varying(250), rev bigint, CONSTRAINT identifier_pk PRIMARY KEY (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS systemmetadata ( guid text NOT NULL, series_id text, serial_version character varying(256), date_uploaded timestamp, rights_holder character varying(250), checksum character varying(512), checksum_algorithm character varying(250), origin_member_node character varying(250), authoritive_member_node character varying(250), date_modified timestamp, submitter character varying(256), object_format character varying(256), size character varying(256), archived boolean, replication_allowed boolean, number_replicas bigint, obsoletes text, obsoleted_by text, CONSTRAINT systemmetadata_pk PRIMARY KEY (guid));] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS xml_access ( guid text, accessfileid text, principal_name character varying(100), permission bigint, perm_type character varying(32), perm_order character varying(32), begin_time date, end_time date, ticket_count bigint, subtreeid character varying(32), startnodeid bigint, endnodeid bigint, CONSTRAINT xml_access_ck CHECK (begin_time < end_time)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationpolicy ( guid text, member_node character varying(250), policy text, CONSTRAINT smreplicationpolicy_fk FOREIGN KEY (guid) REFERENCES systemmetadata (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus ( guid text, member_node character varying(250), status character varying(250), date_verified timestamp, CONSTRAINT smreplicationstatus_fk FOREIGN KEY (guid) REFERENCES systemmetadata (guid)); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('891f20463b023bef25758cabee18b460.1.1', NULL, '1', '2013-08-01 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'c3450ab5803151f78e9e8f91f30f285a', 'MD5', '', '', '2013-08-01 10:17:42.117', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.1.0', '7482', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('6f632bd1cc2772bdcc43bafdbb9d8669.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '709eee7f02ff1f12a9084b906ee0770e', 'MD5', '', '', '2013-07-31 15:29:44.429', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14230', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('261585355b62129e038fabdacc1cd9fa.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eb0b66914142de3e6b2ed949f87096de', 'MD5', '', '', '2013-07-31 15:29:46.774', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14472', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco3-e2fab857d20b994edb1ad65069407423.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '14b343527abc4892fb3b7e50b0b4b096', 'MD5', '', '', '2013-07-31 17:39:09.264', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14514', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco3-f6fcf091959497c2a77967b732d0e631.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'de2c9e3c4a700e3816d4140b8319cce0', 'MD5', '', '', '2013-07-31 17:39:11.085', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '13424', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-6f632bd1cc2772bdcc43bafdbb9d8669.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '709eee7f02ff1f12a9084b906ee0770e', 'MD5', '', '', '2013-07-31 17:41:34.387', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14230', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-261585355b62129e038fabdacc1cd9fa.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eb0b66914142de3e6b2ed949f87096de', 'MD5', '', '', '2013-07-31 17:41:36.253', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14472', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-e2fab857d20b994edb1ad65069407423.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '14b343527abc4892fb3b7e50b0b4b096', 'MD5', '', '', '2013-07-31 17:41:38.243', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '14514', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-f6fcf091959497c2a77967b732d0e631.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'de2c9e3c4a700e3816d4140b8319cce0', 'MD5', '', '', '2013-07-31 17:41:40.2', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '13424', false, false, -1, NULL, NULL); ] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO systemmetadata VALUES ('pisco-test-774d0eb40bb051046a5469be7d912d30.1.1', NULL, '1', '2013-07-31 17:00:00', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', '1842c6ce6c398afe62f15a01063b39a9', 'MD5', '', '', '2013-07-31 17:41:42.331', 'uid=cjones,o=NCEAS,dc=ecoinformatics,dc=org', 'eml://ecoinformatics.org/eml-2.0.1', '17211', false, false, -1, NULL, NULL);] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: sysMetaStatusList statement is: prep252: SELECT guid, serial_version, date_modified, archived FROM systemmetadata ORDER BY guid; [org.dataone.cn.dao.SystemMetadataDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationpolicy;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS xml_access;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS systemmetadata;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS identifier;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.692 sec
Running org.dataone.cn.dao.ReplicationDaoMetacatImplTest
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','QUEUED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:2','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Getting recently failed replicas by node. [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Calendar date is: 2018-09-07 18:44:00 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Cutoff date is: 2018-09-07 17:44:00.715 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: getRecentFailedReplicas statement is: prep253: SELECT member_node, count(status) AS count FROM smreplicationstatus WHERE status = 'FAILED' AND date_verified >= ? GROUP BY member_node ORDER BY member_node; {1: TIMESTAMP '2018-09-07 17:44:00.715'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Failed replicas by node result size is 0 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Recent failed replica map by node: [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:1','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid5','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid6','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getMemberNodesWithQueuedReplica statement is: prep254: SELECT DISTINCT member_node FROM smreplicationstatus WHERE status='QUEUED'; [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Getting recently completed replicas by node. [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Calendar date is: 2018-09-07 18:44:00 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Cutoff date is: 2018-09-07 17:44:00.724 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: getRecentCompletedReplicas statement is: prep255: SELECT member_node, count(status) AS count FROM smreplicationstatus WHERE status = 'COMPLETED' AND date_verified >= ? GROUP BY member_node ORDER BY member_node; {1: TIMESTAMP '2018-09-07 17:44:00.724'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Recent completed replicas by node result size is 0 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Recent completed replica map by node: [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','cnDev','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','COMPLETED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getCompletedMemberNodeReplicas statement is: prep256: SELECT DISTINCT guid, date_verified FROM smreplicationstatus WHERE date_verified <= ? AND status = 'COMPLETED' AND member_node <> 'cnDev' ORDER BY date_verified ASC ; {1: TIMESTAMP '2018-09-07 18:44:00.727'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Getting current entry counts by node status. [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getCountsByNodeStatus statement is: prep257: SELECT member_node, status, count(status) AS count FROM smreplicationstatus GROUP BY member_node, status ORDER BY member_node, status; [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Counts by node-status result size is 3 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid7','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:3','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep258: SELECT count(*) FROM smreplicationstatus WHERE guid = ? AND member_node = ? AND status = 'QUEUED' {1: 'nosuch', 2: 'mn:test:2'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep259: SELECT count(*) FROM smreplicationstatus WHERE guid = ? AND member_node = ? AND status = 'QUEUED' {1: 'test_guid3', 2: 'mn:test:2'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep260: SELECT count(*) FROM smreplicationstatus WHERE guid = ? AND member_node = ? AND status = 'QUEUED' {1: 'test_guid4', 2: 'mn:test:3'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','QUEUED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Getting current pending replicas by node. [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getPendingReplicasbyNode statement is: prep261: SELECT member_node, count(status) AS count FROM smreplicationstatus WHERE status = 'REQUESTED' OR status = 'QUEUED' GROUP BY member_node ORDER BY member_node; [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Pending replicas by node result size is 2 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Pending replica map by node: [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Node: mn:test:2, count: 1 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Node: mn:test:1, count: 2 [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid7','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid5','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid6','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:1','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid5','mn:test:3','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid6','mn:test:4','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:4','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicaCountByNode statement is: prep262: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED'; {1: 'mn:test:33'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicaCountByNode statement is: prep263: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED'; {1: 'mn:test:1'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicaCountByNode statement is: prep264: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED'; {1: 'mn:test:2'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicaCountByNode statement is: prep265: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED'; {1: 'mn:test:3'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicaCountByNode statement is: prep266: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED'; {1: 'mn:test:4'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid7','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid5','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid6','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid4','mn:test:1','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid5','mn:test:3','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid6','mn:test:4','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:4','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep267: SELECT guid, member_node, status, date_verified FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED' ORDER BY date_verified ASC; {1: 'mn:test:1'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep268: SELECT guid, member_node, status, date_verified FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED' ORDER BY date_verified ASC; {1: 'mn:test:2'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep269: SELECT guid, member_node, status, date_verified FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED' ORDER BY date_verified ASC; {1: 'mn:test:3'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getQueuedReplicasByDate statement is: prep270: SELECT guid, member_node, status, date_verified FROM smreplicationstatus WHERE member_node = ? AND status = 'QUEUED' ORDER BY date_verified ASC; {1: 'mn:test:4'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getRequestedReplicasByDate statement is: prep271: SELECT count(*) FROM smreplicationstatus WHERE member_node = ? AND status = 'REQUESTED'; {1: 'mn:test:1'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','QUEUED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:3','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getRequestedReplicasByDate statement is: prep272: SELECT guid, member_node, status, date_verified FROM smreplicationstatus WHERE date_verified <= ? AND status = 'REQUESTED' ORDER BY date_verified ASC; {1: TIMESTAMP '2018-09-07 18:44:00.77'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [CREATE TABLE IF NOT EXISTS smreplicationstatus (guid text, member_node varchar(250), status varchar(250), date_verified timestamp)] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','mn:test:1','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid','cnDev','COMPLETED',TIMESTAMP '2011-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:1','REQUESTED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid2','mn:test:2','COMPLETED',TIMESTAMP '2012-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [INSERT INTO smreplicationstatus VALUES ('test_guid3','mn:test:1','REQUESTED',TIMESTAMP '2020-01-01 12:00:00')] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing prepared SQL query [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Executing prepared SQL statement [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: getCompletedCoordinatingNodeReplicas statement is: prep273: SELECT DISTINCT guid, date_verified FROM smreplicationstatus WHERE date_verified <= ? AND status = 'COMPLETED' AND member_node = 'cnDev' ORDER BY date_verified ASC; {1: TIMESTAMP '2018-09-07 18:44:00.774'} [org.dataone.cn.dao.ReplicationDaoMetacatImpl]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Executing SQL statement [DROP TABLE IF EXISTS smreplicationstatus;] [org.springframework.jdbc.core.JdbcTemplate]
20180907-18:44:00: [DEBUG]: Fetching JDBC Connection from DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
20180907-18:44:00: [DEBUG]: Returning JDBC Connection to DataSource [org.springframework.jdbc.datasource.DataSourceUtils]
Tests run: 12, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.068 sec
Running org.dataone.cn.log.MetricLogEntryTest
{"event":"synchronization queued","threadName":"main","threadId":1,"dateLogged":"2018-09-07T18:44:00.777+00:00"}
20180907-18:44:00: [INFO]: {"event":"synchronization queued","threadName":"main","threadId":1,"dateLogged":"2018-09-07T18:44:00.777+00:00"} [org.dataone.cn.log.MetricLogEntryTest]
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Results :
Failed tests: testAddCountry(org.dataone.cn.ldap.LdapServiceTestUnit): [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : ADD_REQUEST
testAddUnit(org.dataone.cn.ldap.LdapServiceTestUnit): [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : ADD_REQUEST
testAddDc(org.dataone.cn.ldap.LdapServiceTestUnit): Timeout waiting for idle object
testCheckAttributeValue(org.dataone.cn.ldap.LdapServiceTestUnit): Timeout waiting for idle object
testGetAttributeValues(org.dataone.cn.ldap.LdapServiceTestUnit): Timeout waiting for idle object
testAddOrg(org.dataone.cn.ldap.LdapServiceTestUnit): Timeout waiting for idle object
Tests run: 36, Failures: 6, Errors: 0, Skipped: 0
[ERROR] There are test failures.
Please refer to /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/surefire-reports for the individual test results.
[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_common ---
[INFO] Building jar: /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT.jar
[INFO]
[INFO] --- maven-jar-plugin:2.2:test-jar (default) @ d1_cn_common ---
[INFO] Building jar: /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT-tests.jar
[INFO]
[INFO] --- maven-install-plugin:2.3:install (default-install) @ d1_cn_common ---
[INFO] Installing /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT.jar to /var/lib/jenkins/.m2/repository/org/dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT.jar
[INFO] Installing /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/pom.xml to /var/lib/jenkins/.m2/repository/org/dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT.pom
[INFO] Installing /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT-tests.jar to /var/lib/jenkins/.m2/repository/org/dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT-tests.jar
[INFO]
[INFO] --- buildnumber-maven-plugin:1.4:create (default) @ d1_cn_common ---
[INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common' && 'svn' '--non-interactive' 'info'
[INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common
[INFO] Storing buildNumber: 19319 at timestamp: 1536345842949
[INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common' && 'svn' '--non-interactive' 'info'
[INFO] Working directory: /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common
[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_common ---
[INFO]
Loading source files for package org.dataone.cn.batch.exceptions...
Loading source files for package org.dataone.cn...
Loading source files for package org.dataone.cn.hazelcast...
Loading source files for package org.dataone.cn.hazelcast.membership...
Loading source files for package org.dataone.cn.servlet.http...
Loading source files for package org.dataone.cn.model.repository...
Loading source files for package org.dataone.cn.synchronization.types...
Loading source files for package org.dataone.cn.ldap...
Loading source files for package org.dataone.cn.dao.exceptions...
Loading source files for package org.dataone.cn.dao...
Loading source files for package org.dataone.cn.log...
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_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/ExecutionDisabledException.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ComponentActivationUtility.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/ClientConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/HazelcastClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/HazelcastClientInstance.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/HazelcastConfigLocationFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/HazelcastInstanceFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/BaseHazelcastMembershipListener.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/ClusterPartitionMembershipListener.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/ClusterPartitionMonitor.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/BufferedServletOutputStream.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/BufferedServletResponseWrapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/ParameterKeys.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/ProxyServletRequestWrapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/D1BaseJpaRepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/H2RepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/PostgresRepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/SyncObject.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/DirContextPooledObjectFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/DirContextProvider.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/LDAPService.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/DataAccessException.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/DaoFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/MetacatDataSourceFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/ReplicationDao.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/ReplicationDao.ReplicaDto.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/ReplicationDaoMetacatImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/ReplicationPolicyEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDao.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.AccessRuleMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.ReplicaEntryMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.ReplicationPolicyEntryMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.SystemMetadataMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.SystemMetadataStatusMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/SystemMetadataStatus.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditEvent.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogClientSolrImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogClientSplunkImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogQueryClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogQueryClientNullObjectImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogWriteClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/AuditLogWriteClientSplunkImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/MetricEvent.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/MetricLogClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/MetricLogClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/MetricLogClientLog4JImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/MetricLogEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/overview-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/constant-values.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/serialized-form.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/class-use/ExecutionDisabledException.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/class-use/ComponentActivationUtility.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/class-use/HazelcastClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/class-use/ClientConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/class-use/HazelcastConfigLocationFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/class-use/HazelcastInstanceFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/class-use/HazelcastClientInstance.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/class-use/BaseHazelcastMembershipListener.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/class-use/ClusterPartitionMembershipListener.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/class-use/ClusterPartitionMonitor.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/class-use/ProxyServletRequestWrapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/class-use/ParameterKeys.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/class-use/BufferedServletResponseWrapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/class-use/BufferedServletOutputStream.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/class-use/H2RepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/class-use/PostgresRepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/class-use/D1BaseJpaRepositoryConfiguration.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/class-use/SyncObject.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/class-use/LDAPService.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/class-use/DirContextProvider.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/class-use/DirContextPooledObjectFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/class-use/DataAccessException.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/ReplicationDao.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/ReplicationDao.ReplicaDto.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/MetacatDataSourceFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/ReplicationDaoMetacatImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDao.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataStatus.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/ReplicationPolicyEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/DaoFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.SystemMetadataStatusMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.ReplicaEntryMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.ReplicationPolicyEntryMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.AccessRuleMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/class-use/SystemMetadataDaoMetacatImpl.SystemMetadataMapper.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/MetricLogClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogQueryClientNullObjectImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogWriteClientSplunkImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogClientSplunkImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogClientFactory.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogWriteClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogQueryClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/MetricLogClientLog4JImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/MetricLogEntry.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/MetricLogClient.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditEvent.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/AuditLogClientSolrImpl.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/class-use/MetricEvent.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/batch/exceptions/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/dao/exceptions/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/hazelcast/membership/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/ldap/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/log/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/model/repository/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/servlet/http/package-use.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/org/dataone/cn/synchronization/types/package-use.html...
Building index for all the packages and classes...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/overview-tree.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/index-all.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/deprecated-list.html...
Building index for all classes...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/allclasses-frame.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/allclasses-noframe.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/index.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/overview-summary.html...
Generating /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/site/apidocs/help-doc.html...
30 warnings
[WARNING] Javadoc Warnings
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/batch/exceptions/ExecutionDisabledException.java:34: warning - @param argument "cause" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/batch/exceptions/ExecutionDisabledException.java:41: warning - @param argument "cause" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/hazelcast/HazelcastClientFactory.java:103: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/hazelcast/HazelcastClientFactory.java:130: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/hazelcast/HazelcastInstanceFactory.java:44: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/model/repository/D1BaseJpaRepositoryConfiguration.java:24: warning - @Configuration is an unknown tag.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/model/repository/D1BaseJpaRepositoryConfiguration.java:24: warning - @EnableJpaRepositories("repository is an unknown tag.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/model/repository/D1BaseJpaRepositoryConfiguration.java:24: warning - @ComponentScan("model is an unknown tag.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see:illegal character: "58" in "http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters"
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see:illegal character: "47" in "http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters"
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see:illegal character: "47" in "http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters"
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see:illegal character: "47" in "http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters"
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see:illegal character: "47" in "http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters"
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:367: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:80: warning - Tag @see: reference not found: http://www.ietf.org/rfc/rfc2254.txt for considerations on special characters
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:247: warning - @param argument "dn:" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:277: warning - @param argument "dn:" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/ldap/LDAPService.java:307: warning - @param argument "dn:" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/ReplicationDao.java:89: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDao.java:41: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDao.java:50: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDao.java:65: warning - @param argument "tableMap" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:348: warning - Tag @see: can't find saveSystemMetadata(org.dataone.service.types.v1.SystemMetadata) in org.dataone.cn.dao.SystemMetadataDao
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:410: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:640: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:754: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:787: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:815: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/src/main/java/org/dataone/cn/dao/SystemMetadataDaoMetacatImpl.java:1352: 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
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 20.178s
[INFO] Finished at: Fri Sep 07 18:44:05 UTC 2018
[INFO] Final Memory: 59M/631M
[INFO] ------------------------------------------------------------------------
Waiting for Jenkins to finish collecting data
[JENKINS] Archiving /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/pom.xml to org.dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT.pom
[JENKINS] Archiving /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT.jar to org.dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT.jar
[JENKINS] Archiving /var/lib/jenkins/jobs/d1_cn_common/workspace/d1_cn_common/target/d1_cn_common-2.4.0-SNAPSHOT-tests.jar to org.dataone/d1_cn_common/2.4.0-SNAPSHOT/d1_cn_common-2.4.0-SNAPSHOT-tests.jar
Notifying upstream projects of job completion
Finished: UNSTABLE