Menu

Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

Help
2016-11-17
2017-01-22
  • Marco Marcantelli

    Hi,
    me again. I have another problem with another partner (EDT-KITS - as2castcert).
    Also in this case the partner can send me messages (from as2castcert to as2vann) but my AS2 server is unable to send messages to him (from as2vann to as2castcert).

    Thank you
    Mark

    This is my partnerships.xml configuration :

        <partner name="as2vann"
                as2_id="edivp1189"
                x509_alias="as2vann"
                email="info@xxxxxxxxx.it"/>
        <partner name="as2castcert"
                as2_id="EDT-KITS"
                x509_alias="as2castcert"
                email="info@zzzzzzzzz.it"/>
    
        <partnership name="as2vann-to-as2castcert">
                <sender name="as2vann"/>
                <receiver name="as2castcert"/>
                <attribute name="protocol" value="as2"/>
                <attribute name="content_transfer_encoding" value="8bit"/>
                <attribute name="subject" value="From as2vann to as2castcert"/>
                <attribute name="mdnsubject" value="Your requested MDN response from $receiver.as2_id$"/>
                <attribute name="as2_url" value="http://rrrrrrrrrrrrrrrrr.iii.fr:10080/inbound/as2"/>
                <attribute name="as2_mdn_to" value="http://rrrrrrrrrrrrrrrrr.iii.fr:10080/inbound/as2"/>
                <attribute name="as2_mdn_options" value="signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA256"/>
                <attribute name="encrypt" value="3DES"/>
                <attribute name="sign" value="SHA256"/>
                <attribute name="resend_max_retries" value="1"/>
                <attribute name="prevent_canonicalization_for_mic" value="false"/>
                <attribute name="no_set_transfer_encoding_for_signing" value="false"/>
                <attribute name="no_set_transfer_encoding_for_encryption" value="false"/>
                <attribute name="rename_digest_to_old_name" value="false"/>
                <attribute name="remove_cms_algorithm_protection_attrib" value="false"/>
        </partnership>
    
        <partnership name="as2castcert-to-as2vann">
                <sender name="as2castcert"/>
                <receiver name="as2vann"/>
                <attribute name="protocol" value="as2"/>
                <attribute name="content_transfer_encoding" value="8bit"/>
                <attribute name="subject" value="From as2castcert to as2vann"/>
                <attribute name="as2_url" value="http://localhost:10080"/>
                <attribute name="as2_mdn_to" value="http://localhost:10081"/>
                <attribute name="as2_mdn_options" value="signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA256"/>
                <attribute name="encrypt" value="3DES"/>
                <attribute name="sign" value="SHA256"/>
                <attribute name="prevent_canonicalization_for_mic" value="false"/>
                <attribute name="remove_cms_algorithm_protection_attrib" value="false"/>
        </partnership>
    

    This this TRACE log :

    11/16/16 10:12:06 DirectoryPollingModule: processing /u/as2_server_new/bin/../config/../data/toas2castcert/prova21.txt
    11/16/16 10:12:06 MessageBuilderModule: file assigned to message /u/as2_server_new/bin/../config/../data/toas2castcert/prova21.txt [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:06 MessageBuilderModule: PARTNERSHIP parms: {as2_mdn_options=signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA256, subject=From as2vann to as2castcert, remove_cms_algorithm_protection_attrib=false, sign=SHA256, prevent_canonicalization_for_mic=false, no_set_transfer_encoding_for_encryption=false, resend_max_retries=1, content_transfer_encoding=8bit, protocol=as2, as2_mdn_to=http://rrrrrrrrrrrrrrrrr.iii.fr:10080/inbound/as2, no_set_transfer_encoding_for_signing=false, encrypt=3DES, as2_url=http://rrrrrrrrrrrrrrrrr.iii.fr:10080/inbound/as2, rename_digest_to_old_name=false, mdnsubject=Your requested MDN response from $receiver.as2_id$} [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:06 MessageBuilderModule: RESEND COUNT extracted from config: 1 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:06 MessageBuilderModule: Message object in directory polling module. Content-Disposition: Attachment; filename="prova21.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova21.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:06 DefaultProcessor: Processor searching for module handler for action: send
    11/16/16 10:12:06 AS2SenderModule: message sender invoked [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Retry count from options: {retries=1, IS_RESEND=N, DIRECTION=SEND}
    11/16/16 10:12:07 AS2SenderModule: Compression type from config: null
    11/16/16 10:12:07 BCCryptoHelper: Calc MIC called with digest: SHA256 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: 8bit
    11/16/16 10:12:07 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
    Content-Disposition::Attachment; filename="prova21.txt"
    11/16/16 10:12:07 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@3e426ea1
    SIGN DIGEST: SHA256
    CERT ALG NAME EXTRACTED: SHA1WITHRSA
    CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA256 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
    SerialNumber: 713837995
    IssuerDN: C=IT,ST=ITALY,L=xxxxxxx,O=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx,OU=IT,CN=as2.cccccccccccccc.it
    Start Date: Sat Oct 31 16:49:30 CET 2015
    Final Date: Tue Oct 28 16:49:30 CET 2025
    SubjectDN: C=IT,ST=ITALY,L=xxxxxxx,O=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx,OU=IT,CN=as2.cccccccccccccc.it
    Public Key: RSA Public Key
    modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
    584b6aeba8fb438d293b1f9cf544523b6d449718
    c444ca0bbc4055cf2655c34a1455105ecdcddd11
    4b61d77d1f24defaff7af9344a81d7797a8fe39e
    82cbfdf64b08e4b1d946d9678180924b46ccb0d8
    1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
    9842d211938e3064e9cf21703f934e0a81be28bd
    df78b9e374e62e47d91a493fd76486873266d2fe
    23d5c695efd79fbd77e819a656aa5557ad35164a
    3a1c681cc562b36aa986fdcaab3aaed99137e6bd
    fa43e86c9f1de60494eaddaa0efcec51879789e4
    ed07725318442e2b324823c32121de9a2b95b69d
    f5ae0583fbbcac83e7dbc48dd17cade5
    Extensions:
    critical(false) 2.5.29.14 value = DER Octet String[20]

    11/16/16 10:12:07 BCCryptoHelper: Signing on MIME part containing the following headers:
    Content-Type == application/EDI-X12
    Content-Transfer-Encoding == 8bit
    Content-Disposition == Attachment; filename="prova21.txt"
    11/16/16 10:12:07 AS2SenderModule: signed data [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 BCCryptoHelper: Encrypting on MIME part containing the following headers:
    Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-256;
    boundary="----=Part_1_2056441510.1479287527328"
    11/16/16 10:12:07 AS2SenderModule: encrypted data [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS
    Original MIC: 4WFbZH+9BxmBP1J2198V5rVkxEBDTDXUf9q6U2F9uvg=, SHA256
    Retry Count: 1
    Original file name : prova21.txt
    Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova21.txt.993ac78a-86d4-4c2c-9282-4391f130b48
    Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
    Sent directory: null [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova21.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova21.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:07 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/16/16 10:12:07 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=sending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA256}
    11/16/16 10:12:07 AS2SenderModule: Connecting to: http://rrrrrrrrrrrrrrrrr.iii.fr:10080/inbound/as2 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:08 AS2SenderModule: transferred 1091742 bytes in 0.504 seconds at 2.67 MBps [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:13 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:13 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:13 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:13 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@uuuuuu.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@uuuuuu.it, x509_alias=as2qqqqqqq}
    Headers:{Date=Wed, 16 Nov 2016 09:18:05 GMT, Date=Wed, 16 Nov 2016 09:18:00 GMT, Message-Id=MOKOsi3472311586c698b85node1EDT0KITS0EASIER0CERT@kit.rrrrrrrrrrrrrrrrrrr.ooo.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha256;boundary="
    =8632758609342065Sterling8632758609342065MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2169}
    Attributes:{}
    Text:
    null
    [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:14 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
    Date == Wed, 16 Nov 2016 09:18:05 GMT
    Date == Wed, 16 Nov 2016 09:18:00 GMT
    Message-Id == MOKOsi3472311586c698b85node1EDT0KITS0EASIER0CERT@kit.rrrrrrrrrrrrrrrrrrr.ooo.fr
    Subject == Signed Message Disposition Notification
    Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha256;boundary="=8632758609342065Sterling8632758609342065MOKO"
    AS2-To == edivp1189
    AS2-From == EDT-KITS
    Server == Jetty(6.1.26)
    AS2-Version == 1.1
    Content-Length == 2169
    11/16/16 10:12:14 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
    Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
    =0278241036395811Sterling0278241036395811MOKO"
    11/16/16 10:12:14 BCCryptoHelper: Signer Attributes: NULL
    11/16/16 10:12:14 BCCryptoHelper: Verified signature for signer info:
    Digest Alg OID: 2.16.840.1.101.3.4.2.1
    Encrypt Alg OID: 1.2.840.113549.1.1.1
    Signer Version: 1
    Content Digest: [-114, -121, -103, -122, -118, 110, 68, -122, 65, -85, -101, 51, 34, 35, -95, 43, -109, 118, -124, -101, -35, 80, -17, -47, -87, -70, 107, 12, 119, 99, 84, -120]
    Content Type: 1.2.840.113549.1.7.1
    SID: CN=EDT-vvvvvvvvvvv,O=vvvvvvvvvvv,C=FR,E=gggggggg@ppp.fr
    Signature: [B@7a6f0843
    Unsigned attribs: null
    Content-transfer-encoding: null
    Certificate: [0]
    Version: 3
    SerialNumber: 1
    IssuerDN: CN=EDT-vvvvvvvvvvv,O=vvvvvvvvvvv,C=FR,E=gggggggg@ppp.fr
    Start Date: Tue Apr 07 15:58:27 CEST 2015
    Final Date: Fri Apr 04 15:58:27 CEST 2025
    SubjectDN: CN=EDT-vvvvvvvvvvv,O=vvvvvvvvvvv,C=FR,E=gggggggg@ppp.fr
    Public Key: RSA Public Key
    modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
    e96f890ff1acc36b7dc77ddd2eea44f512060a0b
    b3abfa816af9b5285b70712793157663cdd7a0b9
    e2ff8f5b972a3611a61d2b7d79c635444a3e186d
    2768f9b2f72a996dcb9d69143cbb84683d5e45e5
    9f2d9a336f89c9c87751d29a23ec150e4252ae31
    cba017becde007746d2a5c42056551f9199c6235
    3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
    d3c819f0070415409d76be85f6efbbda795f8110
    7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
    994f0e36a6846eb9cf27063362867496c2babb21
    991daed03609f9c09db08e75c419d7cc49f7c484
    0d7b68c3b3e2773e6aecfab83942cb1d
    Extensions:
    critical(true) KeyUsage: 0xf4

    11/16/16 10:12:14 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/16/16 10:12:14 AS2Util: Disposition exception processing MDN ... [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/16/16 10:12:14 AS2Util: RESEND requested.... retries to go: 1
    Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova21.txt.993ac78a-86d4-4c2c-9282-4391f130b48 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util: Pending msg object file to retrieve data from in MDN receiver: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova21.txt.993ac78a-86d4-4c2c-9282-4391f130b48.object
    11/16/16 10:12:14 AS2Util: Message file extracted from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova21.txt.993ac78a-86d4-4c2c-9282-4391f130b48
    Message file extracted from original object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova21.txt.993ac78a-86d4-4c2c-9282-4391f130b48 [OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util:
    Old Msg Id: OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS
    Old Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS
    New Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS [OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util: Attempting to rename pending info file : OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS :::: New name: OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS [OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS]
    11/16/16 10:12:14 AS2Util: Renamed pending info file : OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS :::: New name: OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS [OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS]
    11/16/16 10:12:14 DefaultProcessor: Processor searching for module handler for action: resend
    11/16/16 10:12:14 DirectoryResenderModule: message put in resend queue [OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS]
    11/16/16 10:12:14 DirectoryResenderModule: Message object in resender module for storage. Content-Disposition: Attachment; filename="prova21.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova21.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-16112016101214+0100-8437@edivp1189_EDT-KITS]
    11/16/16 10:12:14 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/16/16 10:12:14 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN received indicates an error. Resend queued, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_error, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi3472311586c698b85node1EDT0KITS0EASIER0CERT@kit.rrrrrrrrrrrrrrrrrrr.ooo.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA256}
    11/16/16 10:12:14 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/16/16 10:12:14 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-16112016101206+0100-5836@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN success response received., IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_ok, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi3472311586c698b85node1EDT0KITS0EASIER0CERT@kit.rrrrrrrrrrrrrrrrrrr.ooo.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA256}

     
  • Christopher Broderick

    The remote server is unable to authenticate the messge. Since it does not appear to have sent any details on exactly what failed you may have to get a detailed log from the partner AS2 system to see what the issue is.

    NOTE: SHA256 may not be supported by the partner AS2 system and that would cause the error you are getting. Try using SHA1 as a first step.

     
  • Christopher Broderick

    Some other things you can try in lieu of getting the remote partners log message:
    If you turn on MDN received Mime body part logging in the start_openas2.sh file it may display more info to get a better idea of why it failed.
    Try setting "prevent_canonicalization_for_mic" to "true" (make sure to set it back to false afterwards if it does not work)
    Try setting "remove_cms_algorithm_protection_attrib" to "true"
    Disable preventing restricted HTTP headers by uncommenting EXTRA_PARMS="$EXTRA_PARMS -Dsun.net.http.allowRestrictedHeaders=true" in the start_openas2.sh file (read the OpenAS2HowTo regarding oing this if it works

     

    Last edit: Christopher Broderick 2016-11-17
  • Marco Marcantelli

    Hi,
    I tried to change parameters by removing SHA256 and putting SHA1 but still returns the same error.

            <partnership name="as2vann-to-as2castcert">
                <sender name="as2vann"/>
                <receiver name="as2castcert"/>
                <attribute name="protocol" value="as2"/>
                <attribute name="content_transfer_encoding" value="8bit"/>
                <attribute name="subject" value="From as2vann to as2castcert"/>
                <attribute name="mdnsubject" value="Your requested MDN response from $receiver.as2_id$"/>
                <attribute name="as2_url" value="http://xxxxxxxxxx.zzz.fr:10080/inbound/as2"/>
                <attribute name="as2_mdn_to" value="http://xxxxxxxxxx.zzz.fr:10080/inbound/as2"/>
                <attribute name="as2_mdn_options" value="signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA1"/>
                <attribute name="encrypt" value="3DES"/>
                <attribute name="sign" value="SHA1"/>
                <attribute name="resend_max_retries" value="1"/>
                <attribute name="prevent_canonicalization_for_mic" value="false"/>
                <attribute name="no_set_transfer_encoding_for_signing" value="false"/>
                <attribute name="no_set_transfer_encoding_for_encryption" value="false"/>
                <attribute name="rename_digest_to_old_name" value="false"/>
                <attribute name="remove_cms_algorithm_protection_attrib" value="false"/>
        </partnership>
    
     
  • Christopher Broderick

    Do you know which software and version is running on as2castcert ?
    Also try setting the "content_transfer_encoding" to "binary"

     
    • Marco Marcantelli

      Hi,
      these are the tests that I have done:
      1 Removing SHA256 and putting SHA1, in according with my partner
      2 Setting "prevent_canonicalization_for_mic" to "true"
      3 Setting "remove_cms_algorithm_protection_attrib" to "true"
      4 Setting Dsun.net.http.allowRestrictedHeaders=true"
      5 Setting "content_transfer_encoding" to "binary"

        I tried all possible combinations but still does not work.
      
        In my logs I can see the as2castcert software : AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1 and my partner said that they use this software : Sterling B2B integrator,  rel. 5.2.5
      

      Can I try it without signing ? how it should be set the <attribute name="sign" value="XXXXX"/> parameter for not using signature ?

      I tried also to turn on MDN received Mime body part logging, this is my log :

      11/21/16 09:08:27 DirectoryPollingModule: processing /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt
      11/21/16 09:08:27 MessageBuilderModule: file assigned to message /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 MessageBuilderModule: PARTNERSHIP parms: {as2_mdn_options=signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA1, subject=From as2vann to as2castcert, remove_cms_algorithm_protection_attrib=false, sign=SHA1, prevent_canonicalization_for_mic=false, no_set_transfer_encoding_for_encryption=false, resend_max_retries=1, content_transfer_encoding=binary, protocol=as2, as2_mdn_to=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, no_set_transfer_encoding_for_signing=false, encrypt=3DES, as2_url=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, rename_digest_to_old_name=false, mdnsubject=Your requested MDN response from $receiver.as2_id$} [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 MessageBuilderModule: RESEND COUNT extracted from config: 1 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 MessageBuilderModule: Message object in directory polling module. Content-Disposition: Attachment; filename="prova36.txt"
      Content-Type : application/EDI-X12
      HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
      Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: send
      11/21/16 09:08:27 AS2SenderModule: message sender invoked [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Retry count from options: {retries=1, IS_RESEND=N, DIRECTION=SEND}
      11/21/16 09:08:27 AS2SenderModule: Compression type from config: null
      11/21/16 09:08:27 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
      11/21/16 09:08:27 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
      Content-Disposition::Attachment; filename="prova36.txt"
      11/21/16 09:08:27 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@5d11daf
      SIGN DIGEST: SHA1
      CERT ALG NAME EXTRACTED: SHA1WITHRSA
      CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
      SerialNumber: 713837995
      IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
      Start Date: Sat Oct 31 16:49:30 CET 2015
      Final Date: Tue Oct 28 16:49:30 CET 2025
      SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
      Public Key: RSA Public Key
      modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
      public exponent: 10001

      Signature Algorithm: SHA1WITHRSA
      Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
      584b6aeba8fb438d293b1f9cf544523b6d449718
      c444ca0bbc4055cf2655c34a1455105ecdcddd11
      4b61d77d1f24defaff7af9344a81d7797a8fe39e
      82cbfdf64b08e4b1d946d9678180924b46ccb0d8
      1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
      9842d211938e3064e9cf21703f934e0a81be28bd
      df78b9e374e62e47d91a493fd76486873266d2fe
      23d5c695efd79fbd77e819a656aa5557ad35164a
      3a1c681cc562b36aa986fdcaab3aaed99137e6bd
      fa43e86c9f1de60494eaddaa0efcec51879789e4
      ed07725318442e2b324823c32121de9a2b95b69d
      f5ae0583fbbcac83e7dbc48dd17cade5
      Extensions:
      critical(false) 2.5.29.14 value = DER Octet String[20]

      11/21/16 09:08:27 BCCryptoHelper: Signing on MIME part containing the following headers:
      Content-Type == application/EDI-X12
      Content-Transfer-Encoding == binary
      Content-Disposition == Attachment; filename="prova36.txt"
      11/21/16 09:08:27 AS2SenderModule: signed data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 BCCryptoHelper: Encrypting on MIME part containing the following headers:
      Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
      boundary="----=Part_4_1899669619.1479715707352"
      11/21/16 09:08:27 AS2SenderModule: encrypted data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
      Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
      Retry Count: 1
      Original file name : prova36.txt
      Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
      Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
      Sent directory: null [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
      Content-Type : application/EDI-X12
      HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
      Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: track_msg
      11/21/16 09:08:27 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=sending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
      11/21/16 09:08:27 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:27 AS2SenderModule: transferred 1091470 bytes in 0.183 seconds at 5.704 MBps [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
      Headers:{Date=Mon, 21 Nov 2016 08:14:34 GMT, Date=Mon, 21 Nov 2016 08:14:28 GMT, Message-Id=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
      =42340864286017266Sterling42340864286017266MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2167}
      Attributes:{}
      Text:
      null
      [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
      Date == Mon, 21 Nov 2016 08:14:34 GMT
      Date == Mon, 21 Nov 2016 08:14:28 GMT
      Message-Id == MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
      Subject == Signed Message Disposition Notification
      Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=42340864286017266Sterling42340864286017266MOKO"
      AS2-To == edivp1189
      AS2-From == EDT-KITS
      Server == Jetty(6.1.26)
      AS2-Version == 1.1
      Content-Length == 2167
      11/21/16 09:08:33 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
      Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
      =5725583069291819Sterling5725583069291819MOKO"
      11/21/16 09:08:33 BCCryptoHelper: Signer Attributes: NULL
      11/21/16 09:08:33 BCCryptoHelper: Verified signature for signer info:
      Digest Alg OID: 1.3.14.3.2.26
      Encrypt Alg OID: 1.2.840.113549.1.1.1
      Signer Version: 1
      Content Digest: [-56, 75, -19, 20, 1, 32, 6, 14, -100, 127, 15, 46, -111, -35, -119, 38, 79, -17, 61, 106]
      Content Type: 1.2.840.113549.1.7.1
      SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Signature: [B@247e4c2c
      Unsigned attribs: null
      Content-transfer-encoding: null
      Certificate: [0]
      Version: 3
      SerialNumber: 1
      IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Start Date: Tue Apr 07 15:58:27 CEST 2015
      Final Date: Fri Apr 04 15:58:27 CEST 2025
      SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Public Key: RSA Public Key
      modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
      public exponent: 10001

      Signature Algorithm: SHA1WITHRSA
      Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
      e96f890ff1acc36b7dc77ddd2eea44f512060a0b
      b3abfa816af9b5285b70712793157663cdd7a0b9
      e2ff8f5b972a3611a61d2b7d79c635444a3e186d
      2768f9b2f72a996dcb9d69143cbb84683d5e45e5
      9f2d9a336f89c9c87751d29a23ec150e4252ae31
      cba017becde007746d2a5c42056551f9199c6235
      3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
      d3c819f0070415409d76be85f6efbbda795f8110
      7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
      994f0e36a6846eb9cf27063362867496c2babb21
      991daed03609f9c09db08e75c419d7cc49f7c484
      0d7b68c3b3e2773e6aecfab83942cb1d
      Extensions:
      critical(true) KeyUsage: 0xf4

      11/21/16 09:08:33 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========
      Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=5725583069291819Sterling5725583069291819MOKO"

      --_=5725583069291819Sterling5725583069291819MOKO

      Your message could not be processed.

      --_=5725583069291819Sterling5725583069291819MOKO
      Content-Type: message/disposition-notification

      Original-Recipient: rfc822;EDT-KITS
      Final-Recipient: rfc822;EDT-KITS
      Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
      Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

      --_=5725583069291819Sterling5725583069291819MOKO--

      ========END MIMEBODYPART=========
      11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========

      Your message could not be processed.

      ========END MIMEBODYPART=========
      11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========
      Content-Type: message/disposition-notification

      Original-Recipient: rfc822;EDT-KITS
      Final-Recipient: rfc822;EDT-KITS
      Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
      Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

      ========END MIMEBODYPART=========
      11/21/16 09:08:33 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
      at org.openas2.util.DispositionType.validate(Unknown Source)
      at org.openas2.util.AS2Util.checkMDN(Unknown Source)
      at org.openas2.util.AS2Util.processMDN(Unknown Source)
      at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
      at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
      at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
      at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
      at java.util.TimerThread.mainLoop(Unknown Source)
      at java.util.TimerThread.run(Unknown Source)

      11/21/16 09:08:33 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
      at org.openas2.util.DispositionType.validate(Unknown Source)
      at org.openas2.util.AS2Util.checkMDN(Unknown Source)
      at org.openas2.util.AS2Util.processMDN(Unknown Source)
      at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
      at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
      at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
      at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
      at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
      at java.util.TimerThread.mainLoop(Unknown Source)
      at java.util.TimerThread.run(Unknown Source)

      11/21/16 09:08:33 AS2Util: RESEND requested.... retries to go: 1
      Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: Pending msg object file to retrieve data from in MDN receiver: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object
      11/21/16 09:08:33 AS2Util: Message file extracted from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
      Message file extracted from original object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util:
      Old Msg Id: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
      Old Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
      New Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: Attempting to rename pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:08:33 AS2Util: Renamed pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: resend
      11/21/16 09:08:33 DirectoryResenderModule: message put in resend queue [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:08:33 DirectoryResenderModule: Message object in resender module for storage. Content-Disposition: Attachment; filename="prova36.txt"
      Content-Type : application/EDI-X12
      HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
      Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
      11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN received indicates an error. Resend queued, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_error, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.edt.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
      , SIGNATURE_ALGORITHM=SHA1}
      11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
      11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN success response received., IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_ok, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
      , SIGNATURE_ALGORITHM=SHA1}
      11/21/16 09:09:37 DirectoryResenderModule: processing /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a
      11/21/16 09:09:37 DirectoryResenderModule: loaded message for resend. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 DirectoryResenderModule: Reconstituted Message object in resender. Content-Disposition: Attachment; filename="prova36.txt"
      Content-Type : application/EDI-X12
      HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
      Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: send
      11/21/16 09:09:37 AS2SenderModule: message sender invoked [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Retry count from options: {retries=0, IS_RESEND=Y, DIRECTION=SEND}
      11/21/16 09:09:37 AS2SenderModule: Compression type from config: null
      11/21/16 09:09:37 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
      11/21/16 09:09:37 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
      Content-Disposition::Attachment; filename="prova36.txt"
      11/21/16 09:09:37 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@35151832
      SIGN DIGEST: SHA1
      CERT ALG NAME EXTRACTED: SHA1WITHRSA
      CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
      SerialNumber: 713837995
      IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
      Start Date: Sat Oct 31 16:49:30 CET 2015
      Final Date: Tue Oct 28 16:49:30 CET 2025
      SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
      Public Key: RSA Public Key
      modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
      public exponent: 10001

      Signature Algorithm: SHA1WITHRSA
      Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
      584b6aeba8fb438d293b1f9cf544523b6d449718
      c444ca0bbc4055cf2655c34a1455105ecdcddd11
      4b61d77d1f24defaff7af9344a81d7797a8fe39e
      82cbfdf64b08e4b1d946d9678180924b46ccb0d8
      1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
      9842d211938e3064e9cf21703f934e0a81be28bd
      df78b9e374e62e47d91a493fd76486873266d2fe
      23d5c695efd79fbd77e819a656aa5557ad35164a
      3a1c681cc562b36aa986fdcaab3aaed99137e6bd
      fa43e86c9f1de60494eaddaa0efcec51879789e4
      ed07725318442e2b324823c32121de9a2b95b69d
      f5ae0583fbbcac83e7dbc48dd17cade5
      Extensions:
      critical(false) 2.5.29.14 value = DER Octet String[20]

      11/21/16 09:09:37 BCCryptoHelper: Signing on MIME part containing the following headers:
      Content-Type == application/EDI-X12
      Content-Transfer-Encoding == binary
      Content-Disposition == Attachment; filename="prova36.txt"
      11/21/16 09:09:37 AS2SenderModule: signed data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 BCCryptoHelper: Encrypting on MIME part containing the following headers:
      Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
      boundary="----=Part_7_912813447.1479715777599"
      11/21/16 09:09:37 AS2SenderModule: encrypted data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
      Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
      Retry Count: 0
      Original file name : prova36.txt
      Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
      Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
      Sent directory: null [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
      Content-Type : application/EDI-X12
      HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
      Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: track_msg
      11/21/16 09:09:37 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=resending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
      11/21/16 09:09:37 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:37 AS2SenderModule: transferred 1091462 bytes in 0.185 seconds at 5.641 MBps [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
      Headers:{Date=Mon, 21 Nov 2016 08:15:44 GMT, Date=Mon, 21 Nov 2016 08:15:39 GMT, Message-Id=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
      =2576870268926781Sterling2576870268926781MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2161}
      Attributes:{}
      Text:
      null
      [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
      Date == Mon, 21 Nov 2016 08:15:44 GMT
      Date == Mon, 21 Nov 2016 08:15:39 GMT
      Message-Id == MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
      Subject == Signed Message Disposition Notification
      Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=2576870268926781Sterling2576870268926781MOKO"
      AS2-To == edivp1189
      AS2-From == EDT-KITS
      Server == Jetty(6.1.26)
      AS2-Version == 1.1
      Content-Length == 2161
      11/21/16 09:09:43 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
      Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
      =9903234915679631Sterling9903234915679631MOKO"
      11/21/16 09:09:43 BCCryptoHelper: Signer Attributes: NULL
      11/21/16 09:09:43 BCCryptoHelper: Verified signature for signer info:
      Digest Alg OID: 1.3.14.3.2.26
      Encrypt Alg OID: 1.2.840.113549.1.1.1
      Signer Version: 1
      Content Digest: [-62, 81, -20, 75, -93, 116, -70, -37, 35, -46, 119, -94, 117, 113, 117, -111, -68, 33, 46, 61]
      Content Type: 1.2.840.113549.1.7.1
      SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Signature: [B@2bf873bf
      Unsigned attribs: null
      Content-transfer-encoding: null
      Certificate: [0]
      Version: 3
      SerialNumber: 1
      IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Start Date: Tue Apr 07 15:58:27 CEST 2015
      Final Date: Fri Apr 04 15:58:27 CEST 2025
      SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
      Public Key: RSA Public Key
      modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
      public exponent: 10001

      Signature Algorithm: SHA1WITHRSA
      Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
      e96f890ff1acc36b7dc77ddd2eea44f512060a0b
      b3abfa816af9b5285b70712793157663cdd7a0b9
      e2ff8f5b972a3611a61d2b7d79c635444a3e186d
      2768f9b2f72a996dcb9d69143cbb84683d5e45e5
      9f2d9a336f89c9c87751d29a23ec150e4252ae31
      cba017becde007746d2a5c42056551f9199c6235
      3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
      d3c819f0070415409d76be85f6efbbda795f8110
      7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
      994f0e36a6846eb9cf27063362867496c2babb21
      991daed03609f9c09db08e75c419d7cc49f7c484
      0d7b68c3b3e2773e6aecfab83942cb1d
      Extensions:
      critical(true) KeyUsage: 0xf4

      11/21/16 09:09:43 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========
      Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=9903234915679631Sterling9903234915679631MOKO"

      --_=9903234915679631Sterling9903234915679631MOKO

      Your message could not be processed.

      --_=9903234915679631Sterling9903234915679631MOKO
      Content-Type: message/disposition-notification

      Original-Recipient: rfc822;EDT-KITS
      Final-Recipient: rfc822;EDT-KITS
      Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
      Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

      --_=9903234915679631Sterling9903234915679631MOKO--

      ========END MIMEBODYPART=========
      11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========

      Your message could not be processed.

      ========END MIMEBODYPART=========
      11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      ========BEGIN MIMEBODYPART=========
      Content-Type: message/disposition-notification

      Original-Recipient: rfc822;EDT-KITS
      Final-Recipient: rfc822;EDT-KITS
      Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
      Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

      ========END MIMEBODYPART=========
      11/21/16 09:09:43 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
      at org.openas2.util.DispositionType.validate(Unknown Source)
      at org.openas2.util.AS2Util.checkMDN(Unknown Source)
      at org.openas2.util.AS2Util.processMDN(Unknown Source)
      at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
      at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
      at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
      at java.util.TimerThread.mainLoop(Unknown Source)
      at java.util.TimerThread.run(Unknown Source)

      11/21/16 09:09:43 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
      at org.openas2.util.DispositionType.validate(Unknown Source)
      at org.openas2.util.AS2Util.checkMDN(Unknown Source)
      at org.openas2.util.AS2Util.processMDN(Unknown Source)
      at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
      at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
      at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
      at java.util.TimerThread.mainLoop(Unknown Source)
      at java.util.TimerThread.run(Unknown Source)

      11/21/16 09:09:43 AS2Util: RESEND requested.... retries to go: 0
      Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2SenderModule: Exception receiving synchronous MDN. Message and asociated files cleanup will be attempted but may be in an unknown state. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      org.openas2.OpenAS2Exception: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      at org.openas2.util.AS2Util.resend(Unknown Source)
      at org.openas2.util.AS2Util.processMDN(Unknown Source)
      at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
      at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
      at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
      at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
      at java.util.TimerThread.mainLoop(Unknown Source)
      at java.util.TimerThread.run(Unknown Source)

      11/21/16 09:09:43 DefaultProcessor: Processor searching for module handler for action: track_msg
      11/21/16 09:09:43 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending failed., IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_fail, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
      , SIGNATURE_ALGORITHM=SHA1}
      11/21/16 09:09:43 AS2Util: Deleting pendinginfo file : /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: Cleaning up pending file : rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 from pending folder : /u/as2_server_new/bin/../config/../data/pendingMDN3 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 AS2Util: moved /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 to /u/as2_server_new/bin/../config/../data/toas2castcert/error/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
      11/21/16 09:09:43 DirectoryResenderModule: deleted /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]

       
  • Marco Marcantelli

    Hi,
    these are the tests that I have done:
    1 Removing SHA256 and putting SHA1, in according with my partner
    2 Setting "prevent_canonicalization_for_mic" to "true"
    3 Setting "remove_cms_algorithm_protection_attrib" to "true"
    4 Setting Dsun.net.http.allowRestrictedHeaders=true"
    5 Setting "content_transfer_encoding" to "binary"

      I tried all possible combinations but still does not work.
    
      In my logs I can see the as2castcert software : AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1 and my partner said that they use this software : Sterling B2B integrator,  rel. 5.2.5
    

    Can I try it without signing ? how it should be set the <attribute name="sign" value="XXXXX"/> parameter for not using signature ?

    I tried also to turn on MDN received Mime body part logging, this is my log :

    11/21/16 09:08:27 DirectoryPollingModule: processing /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt
    11/21/16 09:08:27 MessageBuilderModule: file assigned to message /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: PARTNERSHIP parms: {as2_mdn_options=signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA1, subject=From as2vann to as2castcert, remove_cms_algorithm_protection_attrib=false, sign=SHA1, prevent_canonicalization_for_mic=false, no_set_transfer_encoding_for_encryption=false, resend_max_retries=1, content_transfer_encoding=binary, protocol=as2, as2_mdn_to=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, no_set_transfer_encoding_for_signing=false, encrypt=3DES, as2_url=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, rename_digest_to_old_name=false, mdnsubject=Your requested MDN response from $receiver.as2_id$} [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: RESEND COUNT extracted from config: 1 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: Message object in directory polling module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: send
    11/21/16 09:08:27 AS2SenderModule: message sender invoked [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Retry count from options: {retries=1, IS_RESEND=N, DIRECTION=SEND}
    11/21/16 09:08:27 AS2SenderModule: Compression type from config: null
    11/21/16 09:08:27 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
    11/21/16 09:08:27 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
    Content-Disposition::Attachment; filename="prova36.txt"
    11/21/16 09:08:27 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@5d11daf
    SIGN DIGEST: SHA1
    CERT ALG NAME EXTRACTED: SHA1WITHRSA
    CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
    SerialNumber: 713837995
    IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Start Date: Sat Oct 31 16:49:30 CET 2015
    Final Date: Tue Oct 28 16:49:30 CET 2025
    SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Public Key: RSA Public Key
    modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
    584b6aeba8fb438d293b1f9cf544523b6d449718
    c444ca0bbc4055cf2655c34a1455105ecdcddd11
    4b61d77d1f24defaff7af9344a81d7797a8fe39e
    82cbfdf64b08e4b1d946d9678180924b46ccb0d8
    1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
    9842d211938e3064e9cf21703f934e0a81be28bd
    df78b9e374e62e47d91a493fd76486873266d2fe
    23d5c695efd79fbd77e819a656aa5557ad35164a
    3a1c681cc562b36aa986fdcaab3aaed99137e6bd
    fa43e86c9f1de60494eaddaa0efcec51879789e4
    ed07725318442e2b324823c32121de9a2b95b69d
    f5ae0583fbbcac83e7dbc48dd17cade5
    Extensions:
    critical(false) 2.5.29.14 value = DER Octet String[20]

    11/21/16 09:08:27 BCCryptoHelper: Signing on MIME part containing the following headers:
    Content-Type == application/EDI-X12
    Content-Transfer-Encoding == binary
    Content-Disposition == Attachment; filename="prova36.txt"
    11/21/16 09:08:27 AS2SenderModule: signed data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 BCCryptoHelper: Encrypting on MIME part containing the following headers:
    Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
    boundary="----=Part_4_1899669619.1479715707352"
    11/21/16 09:08:27 AS2SenderModule: encrypted data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
    Retry Count: 1
    Original file name : prova36.txt
    Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
    Sent directory: null [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:27 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=sending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:08:27 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: transferred 1091470 bytes in 0.183 seconds at 5.704 MBps [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
    Headers:{Date=Mon, 21 Nov 2016 08:14:34 GMT, Date=Mon, 21 Nov 2016 08:14:28 GMT, Message-Id=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
    =42340864286017266Sterling42340864286017266MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2167}
    Attributes:{}
    Text:
    null
    [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
    Date == Mon, 21 Nov 2016 08:14:34 GMT
    Date == Mon, 21 Nov 2016 08:14:28 GMT
    Message-Id == MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
    Subject == Signed Message Disposition Notification
    Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=42340864286017266Sterling42340864286017266MOKO"
    AS2-To == edivp1189
    AS2-From == EDT-KITS
    Server == Jetty(6.1.26)
    AS2-Version == 1.1
    Content-Length == 2167
    11/21/16 09:08:33 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
    Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
    =5725583069291819Sterling5725583069291819MOKO"
    11/21/16 09:08:33 BCCryptoHelper: Signer Attributes: NULL
    11/21/16 09:08:33 BCCryptoHelper: Verified signature for signer info:
    Digest Alg OID: 1.3.14.3.2.26
    Encrypt Alg OID: 1.2.840.113549.1.1.1
    Signer Version: 1
    Content Digest: [-56, 75, -19, 20, 1, 32, 6, 14, -100, 127, 15, 46, -111, -35, -119, 38, 79, -17, 61, 106]
    Content Type: 1.2.840.113549.1.7.1
    SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Signature: [B@247e4c2c
    Unsigned attribs: null
    Content-transfer-encoding: null
    Certificate: [0]
    Version: 3
    SerialNumber: 1
    IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Start Date: Tue Apr 07 15:58:27 CEST 2015
    Final Date: Fri Apr 04 15:58:27 CEST 2025
    SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Public Key: RSA Public Key
    modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
    e96f890ff1acc36b7dc77ddd2eea44f512060a0b
    b3abfa816af9b5285b70712793157663cdd7a0b9
    e2ff8f5b972a3611a61d2b7d79c635444a3e186d
    2768f9b2f72a996dcb9d69143cbb84683d5e45e5
    9f2d9a336f89c9c87751d29a23ec150e4252ae31
    cba017becde007746d2a5c42056551f9199c6235
    3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
    d3c819f0070415409d76be85f6efbbda795f8110
    7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
    994f0e36a6846eb9cf27063362867496c2babb21
    991daed03609f9c09db08e75c419d7cc49f7c484
    0d7b68c3b3e2773e6aecfab83942cb1d
    Extensions:
    critical(true) KeyUsage: 0xf4

    11/21/16 09:08:33 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=5725583069291819Sterling5725583069291819MOKO"

    --_=5725583069291819Sterling5725583069291819MOKO

    Your message could not be processed.

    --_=5725583069291819Sterling5725583069291819MOKO
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    --_=5725583069291819Sterling5725583069291819MOKO--

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========

    Your message could not be processed.

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:08:33 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:08:33 AS2Util: RESEND requested.... retries to go: 1
    Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Pending msg object file to retrieve data from in MDN receiver: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object
    11/21/16 09:08:33 AS2Util: Message file extracted from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Message file extracted from original object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util:
    Old Msg Id: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Old Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    New Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Attempting to rename pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Renamed pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: resend
    11/21/16 09:08:33 DirectoryResenderModule: message put in resend queue [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DirectoryResenderModule: Message object in resender module for storage. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN received indicates an error. Resend queued, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_error, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.edt.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN success response received., IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_ok, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:37 DirectoryResenderModule: processing /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a
    11/21/16 09:09:37 DirectoryResenderModule: loaded message for resend. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DirectoryResenderModule: Reconstituted Message object in resender. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: send
    11/21/16 09:09:37 AS2SenderModule: message sender invoked [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Retry count from options: {retries=0, IS_RESEND=Y, DIRECTION=SEND}
    11/21/16 09:09:37 AS2SenderModule: Compression type from config: null
    11/21/16 09:09:37 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
    11/21/16 09:09:37 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
    Content-Disposition::Attachment; filename="prova36.txt"
    11/21/16 09:09:37 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@35151832
    SIGN DIGEST: SHA1
    CERT ALG NAME EXTRACTED: SHA1WITHRSA
    CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
    SerialNumber: 713837995
    IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Start Date: Sat Oct 31 16:49:30 CET 2015
    Final Date: Tue Oct 28 16:49:30 CET 2025
    SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Public Key: RSA Public Key
    modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
    584b6aeba8fb438d293b1f9cf544523b6d449718
    c444ca0bbc4055cf2655c34a1455105ecdcddd11
    4b61d77d1f24defaff7af9344a81d7797a8fe39e
    82cbfdf64b08e4b1d946d9678180924b46ccb0d8
    1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
    9842d211938e3064e9cf21703f934e0a81be28bd
    df78b9e374e62e47d91a493fd76486873266d2fe
    23d5c695efd79fbd77e819a656aa5557ad35164a
    3a1c681cc562b36aa986fdcaab3aaed99137e6bd
    fa43e86c9f1de60494eaddaa0efcec51879789e4
    ed07725318442e2b324823c32121de9a2b95b69d
    f5ae0583fbbcac83e7dbc48dd17cade5
    Extensions:
    critical(false) 2.5.29.14 value = DER Octet String[20]

    11/21/16 09:09:37 BCCryptoHelper: Signing on MIME part containing the following headers:
    Content-Type == application/EDI-X12
    Content-Transfer-Encoding == binary
    Content-Disposition == Attachment; filename="prova36.txt"
    11/21/16 09:09:37 AS2SenderModule: signed data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 BCCryptoHelper: Encrypting on MIME part containing the following headers:
    Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
    boundary="----=Part_7_912813447.1479715777599"
    11/21/16 09:09:37 AS2SenderModule: encrypted data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
    Retry Count: 0
    Original file name : prova36.txt
    Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
    Sent directory: null [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:09:37 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=resending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:37 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: transferred 1091462 bytes in 0.185 seconds at 5.641 MBps [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
    Headers:{Date=Mon, 21 Nov 2016 08:15:44 GMT, Date=Mon, 21 Nov 2016 08:15:39 GMT, Message-Id=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
    =2576870268926781Sterling2576870268926781MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2161}
    Attributes:{}
    Text:
    null
    [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
    Date == Mon, 21 Nov 2016 08:15:44 GMT
    Date == Mon, 21 Nov 2016 08:15:39 GMT
    Message-Id == MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
    Subject == Signed Message Disposition Notification
    Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=2576870268926781Sterling2576870268926781MOKO"
    AS2-To == edivp1189
    AS2-From == EDT-KITS
    Server == Jetty(6.1.26)
    AS2-Version == 1.1
    Content-Length == 2161
    11/21/16 09:09:43 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
    Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
    =9903234915679631Sterling9903234915679631MOKO"
    11/21/16 09:09:43 BCCryptoHelper: Signer Attributes: NULL
    11/21/16 09:09:43 BCCryptoHelper: Verified signature for signer info:
    Digest Alg OID: 1.3.14.3.2.26
    Encrypt Alg OID: 1.2.840.113549.1.1.1
    Signer Version: 1
    Content Digest: [-62, 81, -20, 75, -93, 116, -70, -37, 35, -46, 119, -94, 117, 113, 117, -111, -68, 33, 46, 61]
    Content Type: 1.2.840.113549.1.7.1
    SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Signature: [B@2bf873bf
    Unsigned attribs: null
    Content-transfer-encoding: null
    Certificate: [0]
    Version: 3
    SerialNumber: 1
    IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Start Date: Tue Apr 07 15:58:27 CEST 2015
    Final Date: Fri Apr 04 15:58:27 CEST 2025
    SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Public Key: RSA Public Key
    modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
    e96f890ff1acc36b7dc77ddd2eea44f512060a0b
    b3abfa816af9b5285b70712793157663cdd7a0b9
    e2ff8f5b972a3611a61d2b7d79c635444a3e186d
    2768f9b2f72a996dcb9d69143cbb84683d5e45e5
    9f2d9a336f89c9c87751d29a23ec150e4252ae31
    cba017becde007746d2a5c42056551f9199c6235
    3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
    d3c819f0070415409d76be85f6efbbda795f8110
    7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
    994f0e36a6846eb9cf27063362867496c2babb21
    991daed03609f9c09db08e75c419d7cc49f7c484
    0d7b68c3b3e2773e6aecfab83942cb1d
    Extensions:
    critical(true) KeyUsage: 0xf4

    11/21/16 09:09:43 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=9903234915679631Sterling9903234915679631MOKO"

    --_=9903234915679631Sterling9903234915679631MOKO

    Your message could not be processed.

    --_=9903234915679631Sterling9903234915679631MOKO
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    --_=9903234915679631Sterling9903234915679631MOKO--

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========

    Your message could not be processed.

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 AS2Util: RESEND requested.... retries to go: 0
    Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Exception receiving synchronous MDN. Message and asociated files cleanup will be attempted but may be in an unknown state. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.OpenAS2Exception: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    at org.openas2.util.AS2Util.resend(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:09:43 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending failed., IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_fail, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:43 AS2Util: Deleting pendinginfo file : /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Cleaning up pending file : rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 from pending folder : /u/as2_server_new/bin/../config/../data/pendingMDN3 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: moved /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 to /u/as2_server_new/bin/../config/../data/toas2castcert/error/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 DirectoryResenderModule: deleted /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]

     
  • Marco Marcantelli

    Hi,
    these are the tests that I have done:
    1 Removing SHA256 and putting SHA1, in according with my partner
    2 Setting "prevent_canonicalization_for_mic" to "true"
    3 Setting "remove_cms_algorithm_protection_attrib" to "true"
    4 Setting Dsun.net.http.allowRestrictedHeaders=true"
    5 Setting "content_transfer_encoding" to "binary"

      I tried all possible combinations but still does not work.
    
      In my logs I can see the as2castcert software : AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1 and my partner said that they use this software : Sterling B2B integrator,  rel. 5.2.5
    

    Can I try it without signing ? how it should be set the <attribute name="sign" value="XXXXX"/> parameter for not using signature ?

    I tried also to turn on MDN received Mime body part logging, this is my log :

    11/21/16 09:08:27 DirectoryPollingModule: processing /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt
    11/21/16 09:08:27 MessageBuilderModule: file assigned to message /u/as2_server_new/bin/../config/../data/toas2castcert/prova36.txt [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: PARTNERSHIP parms: {as2_mdn_options=signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA1, subject=From as2vann to as2castcert, remove_cms_algorithm_protection_attrib=false, sign=SHA1, prevent_canonicalization_for_mic=false, no_set_transfer_encoding_for_encryption=false, resend_max_retries=1, content_transfer_encoding=binary, protocol=as2, as2_mdn_to=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, no_set_transfer_encoding_for_signing=false, encrypt=3DES, as2_url=http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2, rename_digest_to_old_name=false, mdnsubject=Your requested MDN response from $receiver.as2_id$} [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: RESEND COUNT extracted from config: 1 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 MessageBuilderModule: Message object in directory polling module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: send
    11/21/16 09:08:27 AS2SenderModule: message sender invoked [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Retry count from options: {retries=1, IS_RESEND=N, DIRECTION=SEND}
    11/21/16 09:08:27 AS2SenderModule: Compression type from config: null
    11/21/16 09:08:27 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
    11/21/16 09:08:27 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
    Content-Disposition::Attachment; filename="prova36.txt"
    11/21/16 09:08:27 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@5d11daf
    SIGN DIGEST: SHA1
    CERT ALG NAME EXTRACTED: SHA1WITHRSA
    CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
    SerialNumber: 713837995
    IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Start Date: Sat Oct 31 16:49:30 CET 2015
    Final Date: Tue Oct 28 16:49:30 CET 2025
    SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Public Key: RSA Public Key
    modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
    584b6aeba8fb438d293b1f9cf544523b6d449718
    c444ca0bbc4055cf2655c34a1455105ecdcddd11
    4b61d77d1f24defaff7af9344a81d7797a8fe39e
    82cbfdf64b08e4b1d946d9678180924b46ccb0d8
    1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
    9842d211938e3064e9cf21703f934e0a81be28bd
    df78b9e374e62e47d91a493fd76486873266d2fe
    23d5c695efd79fbd77e819a656aa5557ad35164a
    3a1c681cc562b36aa986fdcaab3aaed99137e6bd
    fa43e86c9f1de60494eaddaa0efcec51879789e4
    ed07725318442e2b324823c32121de9a2b95b69d
    f5ae0583fbbcac83e7dbc48dd17cade5
    Extensions:
    critical(false) 2.5.29.14 value = DER Octet String[20]

    11/21/16 09:08:27 BCCryptoHelper: Signing on MIME part containing the following headers:
    Content-Type == application/EDI-X12
    Content-Transfer-Encoding == binary
    Content-Disposition == Attachment; filename="prova36.txt"
    11/21/16 09:08:27 AS2SenderModule: signed data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 BCCryptoHelper: Encrypting on MIME part containing the following headers:
    Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
    boundary="----=Part_4_1899669619.1479715707352"
    11/21/16 09:08:27 AS2SenderModule: encrypted data [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
    Retry Count: 1
    Original file name : prova36.txt
    Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
    Sent directory: null [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:27 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=sending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:08:27 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:27 AS2SenderModule: transferred 1091470 bytes in 0.183 seconds at 5.704 MBps [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
    Headers:{Date=Mon, 21 Nov 2016 08:14:34 GMT, Date=Mon, 21 Nov 2016 08:14:28 GMT, Message-Id=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
    =42340864286017266Sterling42340864286017266MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2167}
    Attributes:{}
    Text:
    null
    [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
    Date == Mon, 21 Nov 2016 08:14:34 GMT
    Date == Mon, 21 Nov 2016 08:14:28 GMT
    Message-Id == MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
    Subject == Signed Message Disposition Notification
    Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=42340864286017266Sterling42340864286017266MOKO"
    AS2-To == edivp1189
    AS2-From == EDT-KITS
    Server == Jetty(6.1.26)
    AS2-Version == 1.1
    Content-Length == 2167
    11/21/16 09:08:33 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
    Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
    =5725583069291819Sterling5725583069291819MOKO"
    11/21/16 09:08:33 BCCryptoHelper: Signer Attributes: NULL
    11/21/16 09:08:33 BCCryptoHelper: Verified signature for signer info:
    Digest Alg OID: 1.3.14.3.2.26
    Encrypt Alg OID: 1.2.840.113549.1.1.1
    Signer Version: 1
    Content Digest: [-56, 75, -19, 20, 1, 32, 6, 14, -100, 127, 15, 46, -111, -35, -119, 38, 79, -17, 61, 106]
    Content Type: 1.2.840.113549.1.7.1
    SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Signature: [B@247e4c2c
    Unsigned attribs: null
    Content-transfer-encoding: null
    Certificate: [0]
    Version: 3
    SerialNumber: 1
    IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Start Date: Tue Apr 07 15:58:27 CEST 2015
    Final Date: Fri Apr 04 15:58:27 CEST 2025
    SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Public Key: RSA Public Key
    modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
    e96f890ff1acc36b7dc77ddd2eea44f512060a0b
    b3abfa816af9b5285b70712793157663cdd7a0b9
    e2ff8f5b972a3611a61d2b7d79c635444a3e186d
    2768f9b2f72a996dcb9d69143cbb84683d5e45e5
    9f2d9a336f89c9c87751d29a23ec150e4252ae31
    cba017becde007746d2a5c42056551f9199c6235
    3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
    d3c819f0070415409d76be85f6efbbda795f8110
    7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
    994f0e36a6846eb9cf27063362867496c2babb21
    991daed03609f9c09db08e75c419d7cc49f7c484
    0d7b68c3b3e2773e6aecfab83942cb1d
    Extensions:
    critical(true) KeyUsage: 0xf4

    11/21/16 09:08:33 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=5725583069291819Sterling5725583069291819MOKO"

    --_=5725583069291819Sterling5725583069291819MOKO

    Your message could not be processed.

    --_=5725583069291819Sterling5725583069291819MOKO
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    --_=5725583069291819Sterling5725583069291819MOKO--

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========

    Your message could not be processed.

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    ========END MIMEBODYPART=========
    11/21/16 09:08:33 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:08:33 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.receiver.MessageBuilderModule.processDocument(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.processFile(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.updateTracking(Unknown Source)
    at org.openas2.processor.receiver.DirectoryPollingModule.poll(Unknown Source)
    at org.openas2.processor.receiver.PollingModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:08:33 AS2Util: RESEND requested.... retries to go: 1
    Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Pending msg object file to retrieve data from in MDN receiver: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object
    11/21/16 09:08:33 AS2Util: Message file extracted from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Message file extracted from original object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util:
    Old Msg Id: OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    Old Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS
    New Info File: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Attempting to rename pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 AS2Util: Renamed pending info file : OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS :::: New name: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: resend
    11/21/16 09:08:33 DirectoryResenderModule: message put in resend queue [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DirectoryResenderModule: Message object in resender module for storage. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN received indicates an error. Resend queued, IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_error, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.edt.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:08:33 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:08:33 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090827+0100-4116@edivp1189_EDT-KITS, STATE_MSG=Message sent. Message MDN success response received., IS_RESEND=N, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_sent_mdn_received_ok, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi13457015885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:37 DirectoryResenderModule: processing /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a
    11/21/16 09:09:37 DirectoryResenderModule: loaded message for resend. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DirectoryResenderModule: Reconstituted Message object in resender. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: send
    11/21/16 09:09:37 AS2SenderModule: message sender invoked [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Retry count from options: {retries=0, IS_RESEND=Y, DIRECTION=SEND}
    11/21/16 09:09:37 AS2SenderModule: Compression type from config: null
    11/21/16 09:09:37 BCCryptoHelper: Calc MIC called with digest: SHA1 ::: Incl headers? true ::: Prevent canonicalization: false ::: Encoding: binary
    11/21/16 09:09:37 BCCryptoHelper: Calculating MIC on MIMEPART Headers:
    Content-Disposition::Attachment; filename="prova36.txt"
    11/21/16 09:09:37 AS2SenderModule: Params for creating signed body part:: DATA: javax.mail.internet.MimeBodyPart@35151832
    SIGN DIGEST: SHA1
    CERT ALG NAME EXTRACTED: SHA1WITHRSA
    CERT PUB KEY ALG NAME EXTRACTED: RSA [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 BCCryptoHelper: Params for creating SMIME signed generator:: SIGN DIGEST: SHA1 PUB ENCRYPT ALG: RSA X509 CERT: [0] Version: 3
    SerialNumber: 713837995
    IssuerDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Start Date: Sat Oct 31 16:49:30 CET 2015
    Final Date: Tue Oct 28 16:49:30 CET 2025
    SubjectDN: C=IT,ST=ITALY,L=uuuuuu,O=zzzzzzzzzzzzzzzzzzzzzzzzzzzz,OU=IT,CN=as2.oooooooooooo.it
    Public Key: RSA Public Key
    modulus: 9eef74600aae43417f560b946db24dff7e062f5199aec1352448ac590963a7ecd5c34ecfd83ff1c1e983f4bc2c8e7988f13a3ee304079872179be1ae30ef6d3182bc425a1567b905805176f2f4c675cf1097de55a49d807cc052bd2dac1276c4b8a33cdaa8dfd871dc1995f85fe8f64324e2f0b1d97854ddf67a9e0a9871fbc54421b7c4c9c5d1fd778d3af97ddf38e0cf6625a8053bd579fb23366e3b29a6546b7ae30703c5494f60ab3a49344b0aace9d0c7cc07f236cc3a01e032211e8b58c1ef163bbf0f1d8ece6aa4e560b3d81e3e5f938c21eb257b7639371f7f04de436c2ca12fdf5acc7b74513466e3ba7bd3296f3cebc8a8e036cd56367e24a45eff
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 1d874f591586b7a0b000566546cd277017c3c2a5
    584b6aeba8fb438d293b1f9cf544523b6d449718
    c444ca0bbc4055cf2655c34a1455105ecdcddd11
    4b61d77d1f24defaff7af9344a81d7797a8fe39e
    82cbfdf64b08e4b1d946d9678180924b46ccb0d8
    1a9dc93bcc78081a98b6b8deac0e6d9e67e0b747
    9842d211938e3064e9cf21703f934e0a81be28bd
    df78b9e374e62e47d91a493fd76486873266d2fe
    23d5c695efd79fbd77e819a656aa5557ad35164a
    3a1c681cc562b36aa986fdcaab3aaed99137e6bd
    fa43e86c9f1de60494eaddaa0efcec51879789e4
    ed07725318442e2b324823c32121de9a2b95b69d
    f5ae0583fbbcac83e7dbc48dd17cade5
    Extensions:
    critical(false) 2.5.29.14 value = DER Octet String[20]

    11/21/16 09:09:37 BCCryptoHelper: Signing on MIME part containing the following headers:
    Content-Type == application/EDI-X12
    Content-Transfer-Encoding == binary
    Content-Disposition == Attachment; filename="prova36.txt"
    11/21/16 09:09:37 AS2SenderModule: signed data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 BCCryptoHelper: Encrypting on MIME part containing the following headers:
    Content-Type == multipart/signed; protocol="application/pkcs7-signature"; micalg=sha-1;
    boundary="----=Part_7_912813447.1479715777599"
    11/21/16 09:09:37 AS2SenderModule: encrypted data [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Adding custom headers to outer MBP.... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Save Original mic & message id information into file: /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Pending info file written to:/u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Original MIC: B3DUuISbJRi2991cNyPn11DN0MM=, SHA1
    Retry Count: 0
    Original file name : prova36.txt
    Pending message file : /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521
    Error directory: /u/as2_server_new/bin/../config/../data/toas2castcert/error
    Sent directory: null [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: Message object in sender module. Content-Disposition: Attachment; filename="prova36.txt"
    Content-Type : application/EDI-X12
    HEADERS : ;;Content-Disposition::Attachment; filename="prova36.txt"
    Content-Disposition in MSG getData() MIMEPART: application/EDI-X12 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:09:37 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending started, IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_start, RECEIVER_ID=EDT-KITS, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=resending_msg, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:37 AS2SenderModule: Connecting to: http://xxxxxxxxxxxxx.xxx.fr:10080/inbound/as2 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:37 AS2SenderModule: transferred 1091462 bytes in 0.185 seconds at 5.641 MBps [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Message sent. Checking if MDN will be returned... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Waiting for synchronous MDN response... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Synchronous MDN received. Start processing... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Parsing MDN: MDN From:{as2_id=EDT-KITS, name=as2castcert, email=info@cccccc.it, x509_alias=as2castcert}To:{as2_id=edivp1189, name=as2vann, email=info@cccccc.it, x509_alias=as2vannucci}
    Headers:{Date=Mon, 21 Nov 2016 08:15:44 GMT, Date=Mon, 21 Nov 2016 08:15:39 GMT, Message-Id=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, Subject=Signed Message Disposition Notification, Content-Type=multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="
    =2576870268926781Sterling2576870268926781MOKO", AS2-To=edivp1189, AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1, Content-Length=2161}
    Attributes:{}
    Text:
    null
    [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 BCCryptoHelper: Headers on MimeBodyPart passed in to signature verifier:
    Date == Mon, 21 Nov 2016 08:15:44 GMT
    Date == Mon, 21 Nov 2016 08:15:39 GMT
    Message-Id == MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr
    Subject == Signed Message Disposition Notification
    Content-Type == multipart/signed;protocol="application/pkcs7-signature";micalg=sha1;boundary="=2576870268926781Sterling2576870268926781MOKO"
    AS2-To == edivp1189
    AS2-From == EDT-KITS
    Server == Jetty(6.1.26)
    AS2-Version == 1.1
    Content-Length == 2161
    11/21/16 09:09:43 BCCryptoHelper: Checking signature on SIGNED MIME part extracted from multipart contains headers:
    Content-Type == multipart/report;Report-Type=disposition-notification;boundary="
    =9903234915679631Sterling9903234915679631MOKO"
    11/21/16 09:09:43 BCCryptoHelper: Signer Attributes: NULL
    11/21/16 09:09:43 BCCryptoHelper: Verified signature for signer info:
    Digest Alg OID: 1.3.14.3.2.26
    Encrypt Alg OID: 1.2.840.113549.1.1.1
    Signer Version: 1
    Content Digest: [-62, 81, -20, 75, -93, 116, -70, -37, 35, -46, 119, -94, 117, 113, 117, -111, -68, 33, 46, 61]
    Content Type: 1.2.840.113549.1.7.1
    SID: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Signature: [B@2bf873bf
    Unsigned attribs: null
    Content-transfer-encoding: null
    Certificate: [0]
    Version: 3
    SerialNumber: 1
    IssuerDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Start Date: Tue Apr 07 15:58:27 CEST 2015
    Final Date: Fri Apr 04 15:58:27 CEST 2025
    SubjectDN: CN=EDT-King,O=KING,C=FR,E=tttttttttttt@qqq.fr
    Public Key: RSA Public Key
    modulus: 919160d944b6201e6196d7fbd41a027566b4819d2ea330eeb5f01486213b7828ab38afe33a155d83076a34b5b43749a4713bd6ea08d955a7f7b8a171038a4b0f563807430d7f991f9450989540d235816ecd2ff3368a197079da066f1c35364fd980a7b7e16f89e2b930db5bc717f292d0b79bebcdd6c6b589d6f2673b877aebde14eda52163b2cd173a70dfff4162dd03f26f266364ad6dfe4430b3ad52e38fde87838f8e71036cb41b843e2c1345f93fb3c11d7a65bb251a6957cf66769eb259899733ac52128f0c61d05f02244ba7cce5a1150bc64486bce5106557113b452985da73d2121824a50b225b0e54632990cea8cfb2c25e3faee776b5d8aec885
    public exponent: 10001

    Signature Algorithm: SHA1WITHRSA
    Signature: 030401f7786b050aa98ad23abadb2257b9c1f600
    e96f890ff1acc36b7dc77ddd2eea44f512060a0b
    b3abfa816af9b5285b70712793157663cdd7a0b9
    e2ff8f5b972a3611a61d2b7d79c635444a3e186d
    2768f9b2f72a996dcb9d69143cbb84683d5e45e5
    9f2d9a336f89c9c87751d29a23ec150e4252ae31
    cba017becde007746d2a5c42056551f9199c6235
    3cbabf9b3f50adb0a818f9d1f190f98dc6aecfcf
    d3c819f0070415409d76be85f6efbbda795f8110
    7bbd0853054d26ffd8f9f919ce7e4ee29ed8ea02
    994f0e36a6846eb9cf27063362867496c2babb21
    991daed03609f9c09db08e75c419d7cc49f7c484
    0d7b68c3b3e2773e6aecfab83942cb1d
    Extensions:
    critical(true) KeyUsage: 0xf4

    11/21/16 09:09:43 AS2Util: Received MimeBodyPart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: multipart/report;Report-Type=disposition-notification;boundary="_=9903234915679631Sterling9903234915679631MOKO"

    --_=9903234915679631Sterling9903234915679631MOKO

    Your message could not be processed.

    --_=9903234915679631Sterling9903234915679631MOKO
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    --_=9903234915679631Sterling9903234915679631MOKO--

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========

    Your message could not be processed.

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: Report MimeBodyPart from Multipart for inbound MDN: [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    ========BEGIN MIMEBODYPART=========
    Content-Type: message/disposition-notification

    Original-Recipient: rfc822;EDT-KITS
    Final-Recipient: rfc822;EDT-KITS
    Original-Message-ID: OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS
    Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed

    ========END MIMEBODYPART=========
    11/21/16 09:09:43 AS2Util: MDN parsed. Checking MDN report... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: received MDN [Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed] [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Disposition exception on MDN. Disposition: Automatic-action/mdn-sent-automatically;processed/Error: authentication-failed [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 AS2Util: Disposition exception processing MDN ... [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.DispositionException: automatic-action/mdn-sent-automatically; processed/error:authentication-failed
    at org.openas2.util.DispositionType.validate(Unknown Source)
    at org.openas2.util.AS2Util.checkMDN(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 AS2Util: RESEND requested.... retries to go: 0
    Message file from passed in object: /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2SenderModule: Exception receiving synchronous MDN. Message and asociated files cleanup will be attempted but may be in an unknown state. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    org.openas2.OpenAS2Exception: Message abandoned after retry limit reached. [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    at org.openas2.util.AS2Util.resend(Unknown Source)
    at org.openas2.util.AS2Util.processMDN(Unknown Source)
    at org.openas2.processor.sender.AS2SenderModule.handle(Unknown Source)
    at org.openas2.processor.DefaultProcessor.handle(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.processFile(Unknown Source)
    at org.openas2.processor.resender.DirectoryResenderModule.resend(Unknown Source)
    at org.openas2.processor.resender.BaseResenderModule$PollTask.run(Unknown Source)
    at java.util.TimerThread.mainLoop(Unknown Source)
    at java.util.TimerThread.run(Unknown Source)

    11/21/16 09:09:43 DefaultProcessor: Processor searching for module handler for action: track_msg
    11/21/16 09:09:43 DbTrackingModule: Tracking record successfully persisted to database: {MSG_ID=OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS, STATE_MSG=Message sending failed., IS_RESEND=Y, SENDER_ID=edivp1189, DIRECTION=SEND, ENCRYPTION_ALGORITHM=3DES, STATE=msg_send_fail, RECEIVER_ID=EDT-KITS, MDN_ID=MOKOsi25480415885eb86f0node1EDT0KITS0EASIER0CERT@kkkkkkkkkkkkkk.vvvvvvvvvvv.fr, COMPRESSION=null, FILE_NAME=null, MDN_MODE=SYNC, STATUS=verifying_mdn, CONTENT_TRANSFER_ENCODING=null, CONTENT_TYPE=application/EDI-X12, MDN_RESPONSE=Your message could not be processed.
    , SIGNATURE_ALGORITHM=SHA1}
    11/21/16 09:09:43 AS2Util: Deleting pendinginfo file : /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendinginfoMDN3/OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: deleted /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521.object [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: Cleaning up pending file : rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 from pending folder : /u/as2_server_new/bin/../config/../data/pendingMDN3 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 AS2Util: moved /u/as2_server_new/bin/../config/../data/pendingMDN3/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 to /u/as2_server_new/bin/../config/../data/toas2castcert/error/rova36.txt.d0680839-d88a-4a9e-914e-bbcc6f5b521 [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]
    11/21/16 09:09:43 DirectoryResenderModule: deleted /u/as2_server_new/bin/../config/../data/resend/11-21-16-09-09-33.50f95ab7-299b-4569-9171-e620a78af42a [OPENAS2-21112016090833+0100-4832@edivp1189_EDT-KITS]

     
  • Marco Marcantelli

    Hi,
    these are the tests that I have done:
    1 Removing SHA256 and putting SHA1, in according with my partner
    2 Setting "prevent_canonicalization_for_mic" to "true"
    3 Setting "remove_cms_algorithm_protection_attrib" to "true"
    4 Setting Dsun.net.http.allowRestrictedHeaders=true"
    5 Setting "content_transfer_encoding" to "binary"

      I tried all possible combinations but still does not work.
    
      In my logs I can see the as2castcert software : AS2-From=EDT-KITS, Server=Jetty(6.1.26), AS2-Version=1.1 and my partner said that they use this software : Sterling B2B integrator,  rel. 5.2.5
    

    Can I try it without signing ? how it should be set the <attribute name="sign" value="XXXXX"/> parameter for not using signature ?

    I tried also to turn on MDN received Mime body part logging, so I attach my log.

    Thanks
    Mark

     
  • Christopher Broderick

    The mime body part does not provide any information that is helpful to understand exactly what is failing on the remote end.

    However, this discussion was specifically about Sterling Integrator: https://sourceforge.net/p/openas2/discussion/272857/thread/f40e17f8/#7030

    This discussion was taken offline and eventually solved setting "remove_cms_algorithm_protection_attrib" to "true". Please confirm the results using the following attribute settings for VANN to CASTCERT using SHA1 or MD5 for signing (there were reported issues with SHA256 and Sterlng if you read the full script in the discussion):

            <attribute name="content_transfer_encoding" value="binary"/>
            <attribute name="prevent_canonicalization_for_mic" value="false"/>
            <attribute name="remove_cms_algorithm_protection_attrib" value="true"/>
    

    Try the above with the batch script setting DISABLED (ie remove/comment out or set to "false"): -Dsun.net.http.allowRestrictedHeaders=false

    In the discuscussion referenced above, they did report near the top of that discussion that using MD5 as signing algortithm worked (it does not use CMS algorithm protection) so you could try using MD5 to see if you can get successful comms and help figure out the issue here if the above config does not work.

     
  • Christopher Broderick

    FYI: The response from Sterling was unhelpful in the MDN response in that discussion link in last post but the error log that was eventaully obtained from the trading partner using Sterling AS2 contained this:

    2016-05-24 12:23:11.827] ERROR 000000000000 GLOBAL_SCOPE DataFlowStage.doTransform() [MimeUnpackerDT-1775850:DetachedSignatureVerifierDT] caught exception, shutting down.
    com.trustpoint.asn.AsnException: Cannot find class name for OID: Oid 1.2.840.113549.1.9.52
            at com.trustpoint.asn.AsnSetOfAny.setIdBy(Unknown Source)
            at com.trustpoint.asn.AsnStructured.createMember(Unknown Source)
    ....
    ....
            at com.trustpoint.asn.AsnObject.proceed(Unknown Source)
            at com.sterlingcommerce.woodstock.packager.dataflow.dt.DetachedSignatureVerifierDT.transform(DetachedSignatureVerifierDT.java:197)
    ....
    ....
    com.sterlingcommerce.perimeter.api.scheduler.DebugPooledExecutor$Worker.run(DebugPooledExecutor.java:786)
            at java.lang.Thread.run(Thread.java:795)
    [2016-05-24 12:23:11.827] ERROR DataFlowStage.shutdown() [MimeUnpackerDT-1775850:DetachedSignatureVerifierDT] shutting down inputs.
    [2016-05-24 12:23:11.827] ERROR DataFlowStage.shutdown() [MimeUnpackerDT-1775850:DetachedSignatureVerifierDT] shutting down outputs.
    [2016-05-24 12:23:11.827] ERROR DataFlowStage.shutdown() [MimeUnpackerDT-1775850:DetachedSignatureVerifierDT] shutting down local.
    

    In the above you can see it could not identify the CMS protection OID: http://oidref.com/1.2.840.113549.1.9.52

     
  • Marco Marcantelli

    Hi,
    I confirm that with :

      <attribute name="sign" value="SHA1"/>
      <attribute name="content_transfer_encoding" value="binary"/>
      <attribute name="prevent_canonicalization_for_mic" value="false"/>
      <attribute name="remove_cms_algorithm_protection_attrib" value="true"/>
    

    and with :

    -Dsun.net.http.allowRestrictedHeaders=false

    It works !! Also without SIGN it works !!
    Thank You

     

Log in to post a comment.