Files locked by JVM in pendingMDN folder - OpenAS2 v4.8.2

[claudiodegioannibme]

Hi,

I am reaching out because we are encountering a file-locking issue after upgrading our environment to OpenAS2 v4.8.2.

The Issue
Files are getting stuck in the pendingMDN directory. It appears that the JVM itself maintains an active lock on these files even after the initial processing attempt.

• Symptoms: When we try to manually delete these files from the Operating System, we receive an error stating: "File in use by OpenJDK Platform binary".
• Workaround: The files are only released and become deletable after we restart the OpenAS2 service.
• Impact: This prevents the cleanup process and eventually fills up the pending directory, requiring manual intervention.
• Self-Locking: OpenAS2's own cleanup routines are unable to move or delete the files because they are locked by the process itself.

Environment

• OpenAS2 Version: 4.8.2
• Java Version: OpenJDK Runtime Environment Temurin 21.07
• OS: windows server 2019

Has anyone else experienced this with version 4.8.2? Are there any new settings or known bugs regarding file handle management in this release?

Any suggestions or patches would be greatly appreciated.

[uhurusurfa]

Nobody has reported an y issues like this.
Are you seeing any WARN or ERROR level messages in the logs related to the cleanup of files?

[uhurusurfa]

Also, are you using ASYNC or SYNC MDN?

[claudiodegioannibme]

Reply below

[uhurusurfa]

One more thing - do the files that are getting stuck have ".object" extension or no extension?

[claudiodegioannibme]

Hi Christopher,

We receive the following error message

2026-05-07 10:16:34.203 [AS2DirectoryPollingModule] INFO  org.openas2.processor.sender.AS2SenderModule - Connecting to: http://ditechas2.ditechonline.it:6260/as2 [<07052026101634+0200-7ffd36bf-e5e5-4419-9684-2b151a081f68@06606230156_C$3735752491>]
2026-05-07 10:16:34.378 [DirectoryResenderModule] ERROR org.openas2.util.AS2Util - Error moving file to \\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\ : Failed to delete original file 'D:\OpenAS2v2\OpenAS2\.\config\..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227' after copy to '\\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227'
java.io.IOException: Failed to delete original file 'D:\OpenAS2v2\OpenAS2\.\config\..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227' after copy to '\\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227'
	at org.apache.commons.io.FileUtils.moveFile(FileUtils.java:2578)
	at org.apache.commons.io.FileUtils.moveFile(FileUtils.java:2549)
	at org.openas2.util.IOUtil.moveFile(IOUtil.java:221)
	at org.openas2.util.AS2Util.cleanupFiles(AS2Util.java:799)
	at org.openas2.util.AS2Util.resend(AS2Util.java:365)

2026-05-07 10:16:34.379 [DirectoryResenderModule] ERROR org.openas2.util.AS2Util - File cleanup unable to delete the locally stored version of the pending MSG file: D:\OpenAS2v2\OpenAS2\.\config\..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227
java.nio.file.FileSystemException: D:\OpenAS2v2\OpenAS2\.\config\..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227: The process cannot access the file because it is being used by another process
	at java.base/sun.nio.fs.WindowsException.translateToIOException(WindowsException.java:92)
	at java.base/sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:103)
	at java.base/sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:108)
	at java.base/sun.nio.fs.WindowsFileSystemProvider.implDelete(WindowsFileSystemProvider.java:273)
	at java.base/sun.nio.fs.AbstractFileSystemProvider.delete(AbstractFileSystemProvider.java:105)
	at java.base/java.nio.file.Files.delete(Files.java:1153)
	at org.openas2.util.IOUtil.deleteFile(IOUtil.java:256)
	at org.openas2.util.AS2Util.cleanupFiles(AS2Util.java:815)
	at org.openas2.util.AS2Util.resend(AS2Util.java:365)
	at org.openas2.processor.sender.AS2SenderModule.resend(AS2SenderModule.java:264)
	at org.openas2.processor.sender.AS2SenderModule.handle(AS2SenderModule.java:156)

The current configuration is as follows:

<partnership name="AAAAA-BBBB">
        <sender name="AAAAA"/>
        <receiver name="BBBB"/>
        <attribute name="protocol" value="as2"/>
        <attribute name="subject" value="From AAAAA to BBBB"/>
        <attribute name="as2_url" value="http://XXX.XXX.XXX.XXX:10080/bdbd/AS2Controller"/>
        <attribute name="as2_mdn_to" value="http://YYYY.YYYY.YYYY.YYYY:10080"/>
        <attribute name="as2_mdn_options" value="signed-receipt-protocol=optional, pkcs7-signature; signed-receipt-micalg=optional, SHA256"/>
        <attribute name="encrypt" value="3DES"/>
        <attribute name="sign" value="SHA256"/>
        <attribute name="mdnsubject" value="Your requested MDN response from $receiver.as2_id$"/>
        <attribute name="no_chunked_max_size" value="$properties.chunk_max_file_size$"/>
    </partnership>

The only file present is 07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227, which has no extension."

[claudiodegioannibme]

Hi,

I am adding an item; this only happens in the event of a transmission error once all retry attempts have been exhausted.

2026-05-07 11:53:34.200 [DirectoryResenderModule] ERROR org.openas2.util.AS2Util - Message abandoned after retry limit reached. [<07052026114304+0200-d2066130-6695-47ff-bade-0be9f3320a5d@ALDI_UK_A$3735776283>]

[uhurusurfa]

Ah!! I had been building a reply which asked this and only just saw this comment.
Can you confirm the question at the bottom of the comment I last posted please.

[claudiodegioannibme]

Yes i confirm the error comes in cleanup files

[uhurusurfa]

Does this happen with all files sent or only the ones that end up in the resender module (this particular example is a file that is being resent via the DirectoryResenderModule thread as indicated in the log message prefix)?

The code that controls the creation of the pending file as well as the code that does the cleanup do not open a file handle directly on the cleanup files but instead uses the Apache Commons FileUtils commands.

Apaches moveFile actuallly uses a copyfile then delete in your case. This is the Apache method:

    public static void moveFile(final File srcFile, final File destFile, final CopyOption... copyOptions) throws IOException {
        Objects.requireNonNull(destFile, "destFile");
        checkFileExists(srcFile, "srcFile");
        requireAbsent(destFile, "destFile");
        final boolean rename = srcFile.renameTo(destFile);
        if (!rename) {
            // Don't interfere with file date on move, handled by StandardCopyOption.COPY_ATTRIBUTES
            copyFile(srcFile, destFile, false, copyOptions);
            if (!srcFile.delete()) {
                deleteQuietly(destFile);
                throw new IOException("Failed to delete original file '" + srcFile + "' after copy to '" + destFile + "'");
            }
        }
    }

I have searched on this issue more generally and there do seem to be reported issues using Apache Commons FileUtils when the destination is a Windows network drive.

Can you confirm that the file actually does exist in the target network file system:
\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227

[claudiodegioannibme]

The issue it' related to https://issues.apache.org/jira/browse/IO-544 ?
What is the issue ?

[uhurusurfa]

Can you upload any other log file entries containing this string:
07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29

[claudiodegioannibme]

2026-05-07 09:44:43.285 [AS2DirectoryPollingModule] INFO org.openas2.processor.receiver.MessageBuilderModule - File assigned to message: 07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227 [<07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227>]
2026-05-07 09:44:43.285 [AS2DirectoryPollingModule] INFO org.openas2.processor.sender.AS2SenderModule - Message sender invoked for log ID: [<07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227>]
2026-05-07 09:44:43.290 [AS2DirectoryPollingModule] INFO org.openas2.processor.sender.AS2SenderModule - Save Original mic & message id information into file: D:\OpenAS2v2\OpenAS2.\config/../data/pendinginfoMDN3/07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227 [<07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227>]
2026-05-07 09:44:43.292 [AS2DirectoryPollingModule] INFO org.openas2.processor.sender.AS2SenderModule - Connecting to: http://77.243.178.120:10080/SeeburgerAS2/AS2Controller [<07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227>]
2026-05-07 09:45:04.301 [AS2DirectoryPollingModule] INFO org.openas2.util.AS2Util - Renamed pending info file : 07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227 :::: New name: 07052026094504+0200-aa4a6d1e-ca7a-4315-ad92-13905565e638@ALDI_UK_A$3735739227 [<07052026094504+0200-aa4a6d1e-ca7a-4315-ad92-13905565e638@ALDI_UK_A$3735739227>]
2026-05-07 10:16:34.378 [DirectoryResenderModule] ERROR org.openas2.util.AS2Util - Error moving file to \tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\ : Failed to delete original file 'D:\OpenAS2v2\OpenAS2.\config..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227' after copy to '\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227'
java.io.IOException: Failed to delete original file 'D:\OpenAS2v2\OpenAS2.\config..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227' after copy to '\tesinas01\eint_stor\gruppotesi\datasite\orxt\ds_dati\culina\error_prod\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227'
2026-05-07 10:16:34.379 [DirectoryResenderModule] ERROR org.openas2.util.AS2Util - File cleanup unable to delete the locally stored version of the pending MSG file: D:\OpenAS2v2\OpenAS2.\config..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227
java.nio.file.FileSystemException: D:\OpenAS2v2\OpenAS2.\config..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227: The process cannot access the file because it is being used by another process

This is the extract

[uhurusurfa]

Please can you confirm that the file actually existed on the file system:
D:\OpenAS2v2\OpenAS2.\config..\data\pendingMDN3\07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227

From my perspective, this log message is the key to what the real problem is:
2026-05-07 09:45:04.301 [AS2DirectoryPollingModule] INFO org.openas2.util.AS2Util - Renamed pending info file : 07052026094443+0200-4bd484d4-ed52-4bb7-a453-d0dce003aa29@ALDI_UK_A$3735739227 :::: New name: 07052026094504+0200-aa4a6d1e-ca7a-4315-ad92-13905565e638@ALDI_UK_A$3735739227 [<07052026094504+0200-aa4a6d1e-ca7a-4315-ad92-13905565e638@ALDI_UK_A$3735739227>]

So in fact the file was not moved because it no longer existed.
I will run a test to verify this is the issue as soon as I can but please confirm what the name of the file was that was left in the directory.