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).
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}
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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.
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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
========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
========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]
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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
========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
========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]
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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
========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
========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]
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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.
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):
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.
If you would like to refer to this comment somewhere else in this project, copy and paste the following link:
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.
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 :
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}
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.
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
Hi,
I tried to change parameters by removing SHA256 and putting SHA1 but still returns the same error.
Do you know which software and version is running on as2castcert ?
Also try setting the "content_transfer_encoding" to "binary"
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"
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]
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"
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]
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"
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]
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"
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
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):
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.
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:
In the above you can see it could not identify the CMS protection OID: http://oidref.com/1.2.840.113549.1.9.52
Hi,
I confirm that with :
and with :
-Dsun.net.http.allowRestrictedHeaders=false
It works !! Also without SIGN it works !!
Thank You