UnstableConsole Output

Skipping 114 KB.. Full Log
:35: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:35: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:35: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:24:35: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:35: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_201714522242417 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:35: [INFO]: creating a test object.  pid = P2_201714522242417 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:35: [INFO]: SystemMetadata for pid: P2_201714522242417
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_201714522242417</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_201714522242415</obsoletes>
    <dateUploaded>2017-05-26T05:24:35.917+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:24:35.917+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522242420</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:37: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_201714522242417; FilePart:object = /tmp/mmp.output.6358845239091508421.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.4604184105999657605.tmp (1115 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:24:37: [INFO]: object created.  pid = P2_201714522242417 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:37: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:24:47: [INFO]: Created SID (S1_201714522242420) and head PID (P2_201714522242417) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: HEAD https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object/S1_201714522242420 [org.dataone.client.rest.RestClient]
20170526-05:24:48: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: HEAD https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object/P2_201714522242417 [org.dataone.client.rest.RestClient]
20170526-05:24:48: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: CREATING test object... pid: P1_2017145222448652 with a sid: S1_2017145222448657 obsoletes: null obsoletedBy: P2_2017145222448654 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:24:48: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222448652 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: creating a test object.  pid = P1_2017145222448652 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:48: [INFO]: SystemMetadata for pid: P1_2017145222448652
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222448652</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222448654</obsoletedBy>
    <dateUploaded>2017-05-26T05:24:48.671+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:24:48.671+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222448657</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:50: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222448652; FilePart:object = /tmp/mmp.output.2734273704989632823.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1285165511790880555.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:24:50: [INFO]: object created.  pid = P1_2017145222448652 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:24:50: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:00: [INFO]: CREATING test object... pid: P2_2017145222448654 with a sid: S1_2017145222448657 obsoletes: P1_2017145222448652 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:00: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222448654 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [INFO]: creating a test object.  pid = P2_2017145222448654 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:00: [INFO]: SystemMetadata for pid: P2_2017145222448654
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222448654</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222448652</obsoletes>
    <dateUploaded>2017-05-26T05:25:00.602+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:25:00.602+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222448657</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:02: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222448654; FilePart:object = /tmp/mmp.output.3570003484623805071.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.3963741264218485350.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:02: [INFO]: object created.  pid = P2_2017145222448654 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:02: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:12: [INFO]: Created SID (S1_2017145222448657) and head PID (P2_2017145222448654) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:12: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: HEAD https://cn-dev-unm-1.test.dataone.org/cn/v2/object/S1_2017145222448657 [org.dataone.client.rest.RestClient]
20170526-05:25:13: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: HEAD https://cn-dev-unm-1.test.dataone.org/cn/v2/object/P2_2017145222448654 [org.dataone.client.rest.RestClient]
20170526-05:25:13: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: CREATING test object... pid: P1_20171452225136 with a sid: S1_201714522251311 obsoletes: null obsoletedBy: P2_20171452225138 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:13: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_20171452225136 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: creating a test object.  pid = P1_20171452225136 on https://cn-dev-orc-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: SystemMetadata for pid: P1_20171452225136
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_20171452225136</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_20171452225138</obsoletedBy>
    <dateUploaded>2017-05-26T05:25:13.025+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:25:13.025+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522251311</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_20171452225136; FilePart:object = /tmp/mmp.output.1737901726123442363.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.556230891097654768.tmp (1117 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:13: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
java.lang.reflect.InvocationTargetException
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testDescribe(SidCommonTestImplementations.java:409)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
Caused by: org.dataone.client.exception.ClientSideException: Unable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_20171452225136
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1609)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1441)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.createTestObject(SidCommonTestImplementations.java:209)
	at org.dataone.integration.it.testImplementations.SidCNTestImplementations.setupCNCase1(SidCNTestImplementations.java:91)
	... 35 more
Caused by: org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_20171452225136
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1600)
	... 38 more
20170526-05:25:13: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: ***  context label:   DEV [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
                          nodeId  key                       value
=============================================================================================================
20170526-05:25:13: [INFO]: Testing create() method ...  [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:13: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:15: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P12017145222513939; FilePart:object = /tmp/mmp.output.4083167823069368361.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1107930193623877695.tmp (822 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:15: [INFO]: Testing create(), created new object: org.dataone.service.types.v1.Identifier@7b8a30ed [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:16: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/meta/S12017145222513941 [org.dataone.client.rest.RestClient]
20170526-05:25:16: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:17: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P12017145222516235; FilePart:object = /tmp/mmp.output.6836178281373174517.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1786988061771935540.tmp (822 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:17: [INFO]: Testing create(), created new object: org.dataone.service.types.v1.Identifier@7b8b73bf [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:18: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/meta/S12017145222516237 [org.dataone.client.rest.RestClient]
20170526-05:25:18: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:19: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P12017145222518373; FilePart:object = /tmp/mmp.output.476529716921737767.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.6940228669205882978.tmp (822 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:19: [INFO]: Testing create(), created new object: org.dataone.service.types.v1.Identifier@7b8c60b8 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:20: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/meta/S12017145222518376 [org.dataone.client.rest.RestClient]
20170526-05:25:20: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P12017145222520420; FilePart:object = /tmp/mmp.output.5257156633301134732.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.214018988494682796.tmp (822 bytes);  [org.dataone.client.rest.RestClient]
org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P12017145222520420
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testCreate(SidCommonTestImplementations.java:466)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
20170526-05:25:21: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: ***  context label:   DEV [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
                          nodeId  key                       value
=============================================================================================================
20170526-05:25:21: [INFO]: Testing delete() method ...  [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: Testing delete(), Case1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: CREATING test object... pid: P1_2017145222521189 with a sid: S1_2017145222521193 obsoletes: null obsoletedBy: P2_2017145222521191 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:21: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222521189 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: creating a test object.  pid = P1_2017145222521189 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:21: [INFO]: SystemMetadata for pid: P1_2017145222521189
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222521189</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222521191</obsoletedBy>
    <dateUploaded>2017-05-26T05:25:21.207+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:25:21.207+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222521193</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:22: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222521189; FilePart:object = /tmp/mmp.output.2580262394815923374.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.367574481161405333.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:22: [INFO]: object created.  pid = P1_2017145222521189 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:22: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:32: [INFO]: CREATING test object... pid: P2_2017145222521191 with a sid: S1_2017145222521193 obsoletes: P1_2017145222521189 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:32: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222521191 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [INFO]: creating a test object.  pid = P2_2017145222521191 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:32: [INFO]: SystemMetadata for pid: P2_2017145222521191
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222521191</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222521189</obsoletes>
    <dateUploaded>2017-05-26T05:25:32.807+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:25:32.807+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222521193</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:34: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222521191; FilePart:object = /tmp/mmp.output.1849712132154455663.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.2084994583050925071.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:34: [INFO]: object created.  pid = P2_2017145222521191 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:34: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:44: [INFO]: Created SID (S1_2017145222521193) and head PID (P2_2017145222521191) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: DELETE https://cn-dev.test.dataone.org/cn/v2/object/S1_2017145222521193 [org.dataone.client.rest.RestClient]
20170526-05:25:56: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/object/P2_2017145222521191 [org.dataone.client.rest.RestClient]
20170526-05:25:56: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: CREATING test object... pid: P1_2017145222556937 with a sid: S1_2017145222556942 obsoletes: null obsoletedBy: P2_2017145222556939 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:25:56: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222556937 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: creating a test object.  pid = P1_2017145222556937 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:56: [INFO]: SystemMetadata for pid: P1_2017145222556937
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222556937</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222556939</obsoletedBy>
    <dateUploaded>2017-05-26T05:25:56.954+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:25:56.954+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222556942</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:58: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222556937; FilePart:object = /tmp/mmp.output.6000441970095169677.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5358053197113602604.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:25:58: [INFO]: object created.  pid = P1_2017145222556937 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:25:58: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:08: [INFO]: CREATING test object... pid: P2_2017145222556939 with a sid: S1_2017145222556942 obsoletes: P1_2017145222556937 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:08: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222556939 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [INFO]: creating a test object.  pid = P2_2017145222556939 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:08: [INFO]: SystemMetadata for pid: P2_2017145222556939
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222556939</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222556937</obsoletes>
    <dateUploaded>2017-05-26T05:26:08.512+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:26:08.512+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222556942</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:10: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222556939; FilePart:object = /tmp/mmp.output.2562060507537281206.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5176828486520747583.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:26:10: [INFO]: object created.  pid = P2_2017145222556939 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:10: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:20: [INFO]: Created SID (S1_2017145222556942) and head PID (P2_2017145222556939) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:31: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: DELETE https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object/S1_2017145222556942 [org.dataone.client.rest.RestClient]
20170526-05:26:32: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object/P2_2017145222556939 [org.dataone.client.rest.RestClient]
20170526-05:26:32: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: CREATING test object... pid: P1_2017145222632106 with a sid: S1_2017145222632111 obsoletes: null obsoletedBy: P2_2017145222632108 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:32: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222632106 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: creating a test object.  pid = P1_2017145222632106 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:32: [INFO]: SystemMetadata for pid: P1_2017145222632106
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222632106</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222632108</obsoletedBy>
    <dateUploaded>2017-05-26T05:26:32.123+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:26:32.123+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222632111</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:34: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222632106; FilePart:object = /tmp/mmp.output.6820146113176906318.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1724887394527048010.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:26:34: [INFO]: object created.  pid = P1_2017145222632106 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:34: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:44: [INFO]: CREATING test object... pid: P2_2017145222632108 with a sid: S1_2017145222632111 obsoletes: P1_2017145222632106 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:44: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222632108 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [INFO]: creating a test object.  pid = P2_2017145222632108 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:44: [INFO]: SystemMetadata for pid: P2_2017145222632108
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222632108</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222632106</obsoletes>
    <dateUploaded>2017-05-26T05:26:44.147+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:26:44.147+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222632111</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:45: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222632108; FilePart:object = /tmp/mmp.output.7725317650181499859.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.7862143193052236946.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:26:45: [INFO]: object created.  pid = P2_2017145222632108 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:26:45: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:26:55: [INFO]: Created SID (S1_2017145222632111) and head PID (P2_2017145222632108) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: DELETE https://cn-dev-unm-1.test.dataone.org/cn/v2/object/S1_2017145222632111 [org.dataone.client.rest.RestClient]
20170526-05:27:07: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/object/P2_2017145222632108 [org.dataone.client.rest.RestClient]
20170526-05:27:07: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: CREATING test object... pid: P1_201714522277557 with a sid: S1_201714522277563 obsoletes: null obsoletedBy: P2_201714522277561 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:07: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_201714522277557 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: creating a test object.  pid = P1_201714522277557 on https://cn-dev-orc-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:07: [INFO]: SystemMetadata for pid: P1_201714522277557
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_201714522277557</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_201714522277561</obsoletedBy>
    <dateUploaded>2017-05-26T05:27:07.576+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:27:07.576+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522277563</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_201714522277557; FilePart:object = /tmp/mmp.output.5483800855385600358.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.7953254828257501493.tmp (1119 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:27:08: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
java.lang.reflect.InvocationTargetException
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testDelete(SidCommonTestImplementations.java:510)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
Caused by: org.dataone.client.exception.ClientSideException: Unable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_201714522277557
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1609)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1441)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.createTestObject(SidCommonTestImplementations.java:209)
	at org.dataone.integration.it.testImplementations.SidCNTestImplementations.setupCNCase1(SidCNTestImplementations.java:91)
	... 35 more
Caused by: org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_201714522277557
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1600)
	... 38 more
20170526-05:27:08: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: ***  context label:   DEV [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
                          nodeId  key                       value
=============================================================================================================
20170526-05:27:08: [INFO]: Testing listObjects() method ...  [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: Testing listObjects(), Case1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: CREATING test object... pid: P1_201714522278720 with a sid: S1_201714522278724 obsoletes: null obsoletedBy: P2_201714522278722 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:08: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_201714522278720 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: creating a test object.  pid = P1_201714522278720 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:08: [INFO]: SystemMetadata for pid: P1_201714522278720
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_201714522278720</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_201714522278722</obsoletedBy>
    <dateUploaded>2017-05-26T05:27:08.737+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:27:08.737+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522278724</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:10: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_201714522278720; FilePart:object = /tmp/mmp.output.3942849454310820722.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1634270069106589778.tmp (1119 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:27:10: [INFO]: object created.  pid = P1_201714522278720 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:10: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:20: [INFO]: CREATING test object... pid: P2_201714522278722 with a sid: S1_201714522278724 obsoletes: P1_201714522278720 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:20: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_201714522278722 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [INFO]: creating a test object.  pid = P2_201714522278722 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:20: [INFO]: SystemMetadata for pid: P2_201714522278722
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_201714522278722</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_201714522278720</obsoletes>
    <dateUploaded>2017-05-26T05:27:20.625+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:27:20.625+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522278724</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:22: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_201714522278722; FilePart:object = /tmp/mmp.output.183797516592574953.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1044593860321374508.tmp (1115 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:27:22: [INFO]: object created.  pid = P2_201714522278722 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:22: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:32: [INFO]: Created SID (S1_201714522278724) and head PID (P2_201714522278722) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/object?identifier=P2_201714522278722 [org.dataone.client.rest.RestClient]
20170526-05:27:43: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/object?identifier=S1_201714522278724 [org.dataone.client.rest.RestClient]
20170526-05:27:43: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: CREATING test object... pid: P1_2017145222743726 with a sid: S1_2017145222743731 obsoletes: null obsoletedBy: P2_2017145222743728 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:43: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222743726 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: creating a test object.  pid = P1_2017145222743726 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:43: [INFO]: SystemMetadata for pid: P1_2017145222743726
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222743726</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222743728</obsoletedBy>
    <dateUploaded>2017-05-26T05:27:43.742+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:27:43.742+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222743731</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:45: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222743726; FilePart:object = /tmp/mmp.output.7660809565195783649.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.8756613213633642142.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:27:45: [INFO]: object created.  pid = P1_2017145222743726 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:45: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:55: [INFO]: CREATING test object... pid: P2_2017145222743728 with a sid: S1_2017145222743731 obsoletes: P1_2017145222743726 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:27:55: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222743728 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [INFO]: creating a test object.  pid = P2_2017145222743728 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:55: [INFO]: SystemMetadata for pid: P2_2017145222743728
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222743728</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222743726</obsoletes>
    <dateUploaded>2017-05-26T05:27:55.743+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:27:55.743+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222743731</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:57: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222743728; FilePart:object = /tmp/mmp.output.3495102797350047788.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5760914189751645840.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:27:57: [INFO]: object created.  pid = P2_2017145222743728 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:27:57: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:07: [INFO]: Created SID (S1_2017145222743731) and head PID (P2_2017145222743728) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:17: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object?identifier=P2_2017145222743728 [org.dataone.client.rest.RestClient]
20170526-05:28:18: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object?identifier=S1_2017145222743731 [org.dataone.client.rest.RestClient]
20170526-05:28:18: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: CREATING test object... pid: P1_2017145222818492 with a sid: S1_2017145222818497 obsoletes: null obsoletedBy: P2_2017145222818495 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:18: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222818492 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: creating a test object.  pid = P1_2017145222818492 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:18: [INFO]: SystemMetadata for pid: P1_2017145222818492
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222818492</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222818495</obsoletedBy>
    <dateUploaded>2017-05-26T05:28:18.508+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:28:18.508+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222818497</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:20: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222818492; FilePart:object = /tmp/mmp.output.5434851103068351689.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.2468103359187394564.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:28:20: [INFO]: object created.  pid = P1_2017145222818492 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:20: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:30: [INFO]: CREATING test object... pid: P2_2017145222818495 with a sid: S1_2017145222818497 obsoletes: P1_2017145222818492 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:30: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222818495 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [INFO]: creating a test object.  pid = P2_2017145222818495 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:30: [INFO]: SystemMetadata for pid: P2_2017145222818495
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222818495</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222818492</obsoletes>
    <dateUploaded>2017-05-26T05:28:30.502+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:28:30.502+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222818497</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:32: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222818495; FilePart:object = /tmp/mmp.output.1387356939732256481.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.1379921286493567633.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:28:32: [INFO]: object created.  pid = P2_2017145222818495 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:32: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:42: [INFO]: Created SID (S1_2017145222818497) and head PID (P2_2017145222818495) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:52: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/object?identifier=P2_2017145222818495 [org.dataone.client.rest.RestClient]
20170526-05:28:53: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/object?identifier=S1_2017145222818497 [org.dataone.client.rest.RestClient]
20170526-05:28:53: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: CREATING test object... pid: P1_2017145222853127 with a sid: S1_2017145222853131 obsoletes: null obsoletedBy: P2_2017145222853129 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:53: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222853127 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: creating a test object.  pid = P1_2017145222853127 on https://cn-dev-orc-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:53: [INFO]: SystemMetadata for pid: P1_2017145222853127
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222853127</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222853129</obsoletedBy>
    <dateUploaded>2017-05-26T05:28:53.141+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:28:53.141+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222853131</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222853127; FilePart:object = /tmp/mmp.output.6811123061231393693.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.189837149210642189.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:28:54: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
java.lang.reflect.InvocationTargetException
	at sun.reflect.GeneratedMethodAccessor46.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testListObjects(SidCommonTestImplementations.java:570)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
Caused by: org.dataone.client.exception.ClientSideException: Unable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145222853127
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1609)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1441)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.createTestObject(SidCommonTestImplementations.java:209)
	at org.dataone.integration.it.testImplementations.SidCNTestImplementations.setupCNCase1(SidCNTestImplementations.java:91)
	... 34 more
Caused by: org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145222853127
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1600)
	... 37 more
20170526-05:28:54: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: ***  context label:   DEV [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
                          nodeId  key                       value
=============================================================================================================
20170526-05:28:54: [INFO]: Testing isAuthorized() method ...  [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: Testing isAuthorized(), Case1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: CREATING test object... pid: P1_2017145222854126 with a sid: S1_2017145222854131 obsoletes: null obsoletedBy: P2_2017145222854129 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:28:54: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222854126 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: creating a test object.  pid = P1_2017145222854126 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:54: [INFO]: SystemMetadata for pid: P1_2017145222854126
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222854126</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222854129</obsoletedBy>
    <dateUploaded>2017-05-26T05:28:54.140+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:28:54.140+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222854131</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:56: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222854126; FilePart:object = /tmp/mmp.output.2985150337418636232.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.2095925196340513917.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:28:56: [INFO]: object created.  pid = P1_2017145222854126 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:28:56: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:06: [INFO]: CREATING test object... pid: P2_2017145222854129 with a sid: S1_2017145222854131 obsoletes: P1_2017145222854126 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:06: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222854129 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [INFO]: creating a test object.  pid = P2_2017145222854129 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:06: [INFO]: SystemMetadata for pid: P2_2017145222854129
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222854129</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222854126</obsoletes>
    <dateUploaded>2017-05-26T05:29:06.160+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:29:06.160+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222854131</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:07: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222854129; FilePart:object = /tmp/mmp.output.272562218292567641.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.3742498053730224208.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:29:07: [INFO]: object created.  pid = P2_2017145222854129 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:07: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:17: [INFO]: Created SID (S1_2017145222854131) and head PID (P2_2017145222854129) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:18: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/S1_2017145222854131?action=read [org.dataone.client.rest.RestClient]
20170526-05:29:18: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/P2_2017145222854129?action=read [org.dataone.client.rest.RestClient]
20170526-05:29:18: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/S1_2017145222854131?action=write [org.dataone.client.rest.RestClient]
20170526-05:29:19: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/P2_2017145222854129?action=write [org.dataone.client.rest.RestClient]
20170526-05:29:19: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/S1_2017145222854131?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:29:19: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/isAuthorized/P2_2017145222854129?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:29:19: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: CREATING test object... pid: P1_2017145222919793 with a sid: S1_2017145222919798 obsoletes: null obsoletedBy: P2_2017145222919796 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:19: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222919793 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: creating a test object.  pid = P1_2017145222919793 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:19: [INFO]: SystemMetadata for pid: P1_2017145222919793
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222919793</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222919796</obsoletedBy>
    <dateUploaded>2017-05-26T05:29:19.808+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:29:19.808+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222919798</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:21: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222919793; FilePart:object = /tmp/mmp.output.3347969781930409607.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.8520878126588780585.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:29:21: [INFO]: object created.  pid = P1_2017145222919793 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:21: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:31: [INFO]: CREATING test object... pid: P2_2017145222919796 with a sid: S1_2017145222919798 obsoletes: P1_2017145222919793 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:31: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222919796 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [INFO]: creating a test object.  pid = P2_2017145222919796 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:31: [INFO]: SystemMetadata for pid: P2_2017145222919796
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222919796</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222919793</obsoletes>
    <dateUploaded>2017-05-26T05:29:31.608+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:29:31.608+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222919798</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:33: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222919796; FilePart:object = /tmp/mmp.output.8246907302838156852.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5910536737555039057.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:29:33: [INFO]: object created.  pid = P2_2017145222919796 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:33: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:43: [INFO]: Created SID (S1_2017145222919798) and head PID (P2_2017145222919796) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:43: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222919798?action=read [org.dataone.client.rest.RestClient]
20170526-05:29:44: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222919796?action=read [org.dataone.client.rest.RestClient]
20170526-05:29:44: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222919798?action=write [org.dataone.client.rest.RestClient]
20170526-05:29:44: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222919796?action=write [org.dataone.client.rest.RestClient]
20170526-05:29:45: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222919798?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:29:45: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222919796?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:29:45: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: CREATING test object... pid: P1_2017145222945671 with a sid: S1_2017145222945676 obsoletes: null obsoletedBy: P2_2017145222945673 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:45: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145222945671 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: creating a test object.  pid = P1_2017145222945671 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:45: [INFO]: SystemMetadata for pid: P1_2017145222945671
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145222945671</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145222945673</obsoletedBy>
    <dateUploaded>2017-05-26T05:29:45.686+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:29:45.686+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222945676</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:47: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145222945671; FilePart:object = /tmp/mmp.output.1070149750570634574.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5603329500729431044.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:29:47: [INFO]: object created.  pid = P1_2017145222945671 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:47: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:57: [INFO]: CREATING test object... pid: P2_2017145222945673 with a sid: S1_2017145222945676 obsoletes: P1_2017145222945671 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:29:57: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145222945673 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [INFO]: creating a test object.  pid = P2_2017145222945673 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:57: [INFO]: SystemMetadata for pid: P2_2017145222945673
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145222945673</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145222945671</obsoletes>
    <dateUploaded>2017-05-26T05:29:57.544+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:29:57.544+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145222945676</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:59: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145222945673; FilePart:object = /tmp/mmp.output.1795689527253041562.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.4412053345475269578.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:29:59: [INFO]: object created.  pid = P2_2017145222945673 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:29:59: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:09: [INFO]: Created SID (S1_2017145222945676) and head PID (P2_2017145222945673) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:09: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222945676?action=read [org.dataone.client.rest.RestClient]
20170526-05:30:10: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222945673?action=read [org.dataone.client.rest.RestClient]
20170526-05:30:10: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222945676?action=write [org.dataone.client.rest.RestClient]
20170526-05:30:10: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222945673?action=write [org.dataone.client.rest.RestClient]
20170526-05:30:10: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/S1_2017145222945676?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:30:11: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/isAuthorized/P2_2017145222945673?action=changePermission [org.dataone.client.rest.RestClient]
20170526-05:30:11: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: CREATING test object... pid: P1_2017145223011150 with a sid: S1_2017145223011154 obsoletes: null obsoletedBy: P2_2017145223011152 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:11: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145223011150 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: creating a test object.  pid = P1_2017145223011150 on https://cn-dev-orc-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:11: [INFO]: SystemMetadata for pid: P1_2017145223011150
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145223011150</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145223011152</obsoletedBy>
    <dateUploaded>2017-05-26T05:30:11.164+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:30:11.164+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223011154</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145223011150; FilePart:object = /tmp/mmp.output.1067792178188902444.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.960498636841099305.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:30:12: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
java.lang.reflect.InvocationTargetException
	at sun.reflect.GeneratedMethodAccessor46.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testIsAuthorized(SidCommonTestImplementations.java:628)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
Caused by: org.dataone.client.exception.ClientSideException: Unable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223011150
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1609)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1441)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.createTestObject(SidCommonTestImplementations.java:209)
	at org.dataone.integration.it.testImplementations.SidCNTestImplementations.setupCNCase1(SidCNTestImplementations.java:91)
	... 34 more
Caused by: org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223011150
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1600)
	... 37 more
20170526-05:30:12: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: ***  context label:   DEV [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: **************************************************** [org.dataone.integration.ContextAwareTestCaseDataone]
                          nodeId  key                       value
=============================================================================================================
20170526-05:30:12: [INFO]: Testing view() method ...  [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: Testing view(), Case1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: CREATING test object... pid: P1_2017145223012166 with a sid: S1_2017145223012171 obsoletes: null obsoletedBy: P2_2017145223012168 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:12: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145223012166 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: creating a test object.  pid = P1_2017145223012166 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:12: [INFO]: SystemMetadata for pid: P1_2017145223012166
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145223012166</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145223012168</obsoletedBy>
    <dateUploaded>2017-05-26T05:30:12.180+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:30:12.180+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223012171</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:14: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145223012166; FilePart:object = /tmp/mmp.output.2930760545614327063.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.188601416737797297.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:30:14: [INFO]: object created.  pid = P1_2017145223012166 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:14: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:24: [INFO]: CREATING test object... pid: P2_2017145223012168 with a sid: S1_2017145223012171 obsoletes: P1_2017145223012166 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:24: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145223012168 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [INFO]: creating a test object.  pid = P2_2017145223012168 on https://cn-dev.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:24: [INFO]: SystemMetadata for pid: P2_2017145223012168
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145223012168</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145223012166</obsoletes>
    <dateUploaded>2017-05-26T05:30:24.071+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:30:24.071+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223012171</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:25: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145223012168; FilePart:object = /tmp/mmp.output.690841354874700726.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.4029409158397036418.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:30:25: [INFO]: object created.  pid = P2_2017145223012168 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:25: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:35: [INFO]: Created SID (S1_2017145223012171) and head PID (P2_2017145223012168) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:36: [WARN]: Cookie rejected [JSESSIONID="CC29105C305ABE8CCC2C8C290F97B498", version:0, domain:cn-dev.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/S1_2017145223012171" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:30:36: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/views/default/S1_2017145223012171 [org.dataone.client.rest.RestClient]
20170526-05:30:37: [WARN]: Cookie rejected [JSESSIONID="F95AF45FCC6AD04B0CCD45D7646FE8A4", version:0, domain:cn-dev.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/P2_2017145223012168" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:30:37: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev.test.dataone.org/cn/v2/views/default/P2_2017145223012168 [org.dataone.client.rest.RestClient]
20170526-05:30:37: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: CREATING test object... pid: P1_2017145223037587 with a sid: S1_2017145223037592 obsoletes: null obsoletedBy: P2_2017145223037590 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:37: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145223037587 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: creating a test object.  pid = P1_2017145223037587 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:37: [INFO]: SystemMetadata for pid: P1_2017145223037587
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145223037587</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145223037590</obsoletedBy>
    <dateUploaded>2017-05-26T05:30:37.602+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:30:37.602+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223037592</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:39: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145223037587; FilePart:object = /tmp/mmp.output.867067965470928060.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.8517827596220169167.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:30:39: [INFO]: object created.  pid = P1_2017145223037587 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:39: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:49: [INFO]: CREATING test object... pid: P2_2017145223037590 with a sid: S1_2017145223037592 obsoletes: P1_2017145223037587 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:30:49: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_2017145223037590 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [INFO]: creating a test object.  pid = P2_2017145223037590 on https://cn-dev-ucsb-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:49: [INFO]: SystemMetadata for pid: P2_2017145223037590
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_2017145223037590</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_2017145223037587</obsoletes>
    <dateUploaded>2017-05-26T05:30:49.243+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:30:49.243+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223037592</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:51: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-ucsb-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_2017145223037590; FilePart:object = /tmp/mmp.output.1595447648367508610.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.718071972640347524.tmp (1118 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:30:51: [INFO]: object created.  pid = P2_2017145223037590 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:30:51: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:01: [INFO]: Created SID (S1_2017145223037592) and head PID (P2_2017145223037590) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:02: [WARN]: Cookie rejected [JSESSIONID="79A6E73EA2AC42ABFED31EDFC855604A", version:0, domain:cn-dev-ucsb-1.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/S1_2017145223037592" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:31:02: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/views/default/S1_2017145223037592 [org.dataone.client.rest.RestClient]
20170526-05:31:03: [WARN]: Cookie rejected [JSESSIONID="E0279D6C26F7D9CD21E0A02FB70590DB", version:0, domain:cn-dev-ucsb-1.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/P2_2017145223037590" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:31:03: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-ucsb-1.test.dataone.org/cn/v2/views/default/P2_2017145223037590 [org.dataone.client.rest.RestClient]
20170526-05:31:03: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: CREATING test object... pid: P1_201714522313174 with a sid: S1_201714522313178 obsoletes: null obsoletedBy: P2_201714522313176 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:03: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_201714522313174 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: creating a test object.  pid = P1_201714522313174 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:03: [INFO]: SystemMetadata for pid: P1_201714522313174
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_201714522313174</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_201714522313176</obsoletedBy>
    <dateUploaded>2017-05-26T05:31:03.189+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:31:03.189+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522313178</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:05: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_201714522313174; FilePart:object = /tmp/mmp.output.5629206498972369915.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.4574599001138673259.tmp (1119 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:31:05: [INFO]: object created.  pid = P1_201714522313174 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:05: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:15: [INFO]: CREATING test object... pid: P2_201714522313176 with a sid: S1_201714522313178 obsoletes: P1_201714522313174 obsoletedBy: null [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:15: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [WARN]: Unable to find a valid authoritative MN to use for the object: P2_201714522313176 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [INFO]: creating a test object.  pid = P2_201714522313176 on https://cn-dev-unm-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:15: [INFO]: SystemMetadata for pid: P2_201714522313176
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P2_201714522313176</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletes>P1_201714522313174</obsoletes>
    <dateUploaded>2017-05-26T05:31:15.613+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:31:15.613+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_201714522313178</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:17: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-unm-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P2_201714522313176; FilePart:object = /tmp/mmp.output.5311895278494866333.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.2698795172948555774.tmp (1115 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:31:17: [INFO]: object created.  pid = P2_201714522313176 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:17: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:27: [INFO]: Created SID (S1_201714522313178) and head PID (P2_201714522313176) pair. [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:28: [WARN]: Cookie rejected [JSESSIONID="3169C678AB17F837C8D82AAEBA210173", version:0, domain:cn-dev-unm-1.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/S1_201714522313178" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:31:28: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/views/default/S1_201714522313178 [org.dataone.client.rest.RestClient]
20170526-05:31:30: [WARN]: Cookie rejected [JSESSIONID="4246CAF472F7E3F7FD685D11840526FA", version:0, domain:cn-dev-unm-1.test.dataone.org, path:/metacat/, expiry:null] Illegal path attribute "/metacat/". Path of origin: "/cn/v2/views/default/P2_201714522313176" [org.apache.http.client.protocol.ResponseProcessCookies]
20170526-05:31:30: [INFO]: RestClient.doRequestNoBody, thread(1) call Info: GET https://cn-dev-unm-1.test.dataone.org/cn/v2/views/default/P2_201714522313176 [org.dataone.client.rest.RestClient]
20170526-05:31:30: [INFO]: created client for certificate file: cnDevUNM1 with subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: CREATING test object... pid: P1_2017145223130224 with a sid: S1_2017145223130228 obsoletes: null obsoletedBy: P2_2017145223130226 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: created client for certificate file: testRightsHolder with subject: CN=testRightsHolder,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: certificate directory: /etc/dataone/client/testClientCerts/ [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: certificate filename: cnDevUNM1 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
20170526-05:31:30: [INFO]: client setup as Subject: CN=urn:node:cnDevUNM1,DC=dataone,DC=org [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [WARN]: Unable to find a valid authoritative MN to use for the object: P1_2017145223130224 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: creating a test object.  pid = P1_2017145223130224 on https://cn-dev-orc-1.test.dataone.org/cn/v2 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:30: [INFO]: SystemMetadata for pid: P1_2017145223130224
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<ns3:systemMetadata xmlns:ns2="http://ns.dataone.org/service/types/v1" xmlns:ns3="http://ns.dataone.org/service/types/v2.0">
    <serialVersion>1</serialVersion>
    <identifier>P1_2017145223130224</identifier>
    <formatId>eml://ecoinformatics.org/eml-2.0.1</formatId>
    <size>17181</size>
    <checksum algorithm="MD5">03ce09c6b4c3efc1681f3023402998a2</checksum>
    <submitter>CN=urn:node:cnDevUNM1,DC=dataone,DC=org</submitter>
    <rightsHolder>CN=testRightsHolder,DC=dataone,DC=org</rightsHolder>
    <accessPolicy>
        <allow>
            <subject>public</subject>
            <permission>read</permission>
        </allow>
    </accessPolicy>
    <obsoletedBy>P2_2017145223130226</obsoletedBy>
    <dateUploaded>2017-05-26T05:31:30.239+00:00</dateUploaded>
    <dateSysMetadataModified>2017-05-26T05:31:30.239+00:00</dateSysMetadataModified>
    <originMemberNode>bogusAuthoritativeNode</originMemberNode>
    <authoritativeMemberNode>bogusAuthoritativeNode</authoritativeMemberNode>
    <seriesId>S1_2017145223130228</seriesId>
</ns3:systemMetadata>
 [org.dataone.integration.ContextAwareTestCaseDataone]
20170526-05:31:31: [INFO]: RestClient.doRequestMMPBody, thread(1) call Info: POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_2017145223130224; FilePart:object = /tmp/mmp.output.5941058431078338878.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.5330925120927380961.tmp (1122 bytes);  [org.dataone.client.rest.RestClient]
20170526-05:31:31: [WARN]: registering ConnectionManager... [org.dataone.client.utils.HttpConnectionMonitorService]
java.lang.reflect.InvocationTargetException
	at sun.reflect.GeneratedMethodAccessor46.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.testView(SidCommonTestImplementations.java:718)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.rules.Verifier$1.evaluate(Verifier.java:34)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:119)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:101)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.booter.ProviderFactory$ClassLoaderProxy.invoke(ProviderFactory.java:103)
	at com.sun.proxy.$Proxy0.invoke(Unknown Source)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:150)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcess(SurefireStarter.java:91)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:69)
Caused by: org.dataone.client.exception.ClientSideException: Unable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223130224
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1609)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1441)
	at org.dataone.integration.it.testImplementations.SidCommonTestImplementations.createTestObject(SidCommonTestImplementations.java:209)
	at org.dataone.integration.it.testImplementations.SidCNTestImplementations.setupCNCase1(SidCNTestImplementations.java:91)
	... 34 more
Caused by: org.dataone.service.exceptions.NotAuthorized: The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223130224
	at org.dataone.service.util.ExceptionHandler.deserializeXml(ExceptionHandler.java:630)
	at org.dataone.service.util.ExceptionHandler.deserializeXmlAndThrowException(ExceptionHandler.java:517)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:363)
	at org.dataone.service.util.ExceptionHandler.deserializeAndThrowException(ExceptionHandler.java:313)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:107)
	at org.dataone.service.util.ExceptionHandler.filterErrors(ExceptionHandler.java:82)
	at org.dataone.client.rest.HttpMultipartRestClient.doPostRequest(HttpMultipartRestClient.java:463)
	at org.dataone.client.v2.impl.MultipartCNode.create(MultipartCNode.java:611)
	at org.dataone.integration.adapters.CommonCallAdapter.create(CommonCallAdapter.java:492)
	at org.dataone.integration.ContextAwareTestCaseDataone.createTestObject(ContextAwareTestCaseDataone.java:1600)
	... 37 more
Tests run: 9, Failures: 9, Errors: 0, Skipped: 0, Time elapsed: 1,610.037 sec <<< FAILURE!

Results :

Failed tests: 
  testResolve(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Error while creating test object. NotFound : Test object (P1_201714522449124) was not synchronized from https://mn-demo-7.test.dataone.org/knb/d1/mn to https://cn-dev.test.dataone.org/cn/v2 : NotFound : No record found for: P1_201714522449124.  Test object (P1_201714522449124) was not synchronized from https://mn-demo-7.test.dataone.org/knb/d1/mn to https://cn-dev.test.dataone.org/cn/v2 : NotFound : No record found for: P1_201714522449124. 
  testGetSystemMetadata(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145222241646  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testGet(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145222358256  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testDescribe(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_20171452225136  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testCreate(org.dataone.integration.it.testImplementations.SidCNTestImplementations): The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P12017145222520420  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testDelete(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_201714522277557  [for host POST https://cn-dev-orc-1.test.dataone.org/cn/v2/object; MMP message has: ParamPart:pid = P1_201714522277557; FilePart:object = /tmp/mmp.output.5483800855385600358.tmp (17181 bytes); FilePart:sysmeta = /tmp/mmp.output.7953254828257501493.tmp (1119 bytes);  ]
  testListObjects(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145222853127  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testIsAuthorized(org.dataone.integration.it.testImplementations.SidCNTestImplementations): Case: 0 : nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223011150  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]
  testView(org.dataone.integration.it.testImplementations.SidCNTestImplementations): nullUnable to create test object!/The subject listed as CN=urn:node:cnDevUNM1,DC=dataone,DC=org isn't allowed to call create() on a Coordinating Node for pid P1_2017145223130224  [for host https://cn-dev-orc-1.test.dataone.org/cn/v2 ]

Tests run: 9, Failures: 9, Errors: 0, Skipped: 0

[WARNING] File encoding has not been set, using platform encoding UTF-8, i.e. build is platform dependent!
[JENKINS] Recording test results
[INFO] 
[INFO] --- maven-failsafe-plugin:2.8.1:verify (verify) @ d1_integration ---
[INFO] Failsafe report directory: /var/lib/jenkins/jobs/d1_integration_DEV_CN_sid_functional/workspace/target/failsafe-reports
[WARNING] File encoding has not been set, using platform encoding UTF-8, i.e. build is platform dependent!
[ERROR] There are test failures.

Please refer to /var/lib/jenkins/jobs/d1_integration_DEV_CN_sid_functional/workspace/target/failsafe-reports for the individual test results.
[JENKINS] Recording test results
Notifying upstream projects of job completion
Join notifier requires a CauseAction
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 27:20.383s
[INFO] Finished at: Fri May 26 05:31:31 UTC 2017
[INFO] Final Memory: 58M/768M
[INFO] ------------------------------------------------------------------------
Waiting for Jenkins to finish collecting data