addShutdownHook 中にLoggerの出力がされなくなる現象

Question

実現したいこと

java実行中にSystem.exit(1)等で終了した際、終了処理を行うためにRuntime.getRuntime().addShutdownHookを予め定義していたのですが、addShutdownHookの中ではjava.util.logging.Loggerの出力が一切されなくなります。

これは一体どういう理由なのでしょうか？
addShutdownHookは終了処理と同時に平行で進むため、Logger用に確保されていたメモリが解放された といった現象なのでしょうか？
また、可能であれば、addShutdownHook中にLoggerを出力できるようにする方法はあるでしょうか？

下記が現象のサンプルコードです。

package org.example;
import java.util.logging.Logger;

public class Main {
    private static final Logger logger = Logger.getLogger(Main.class.getName());
    public static void main(String[] args) {
        logger.info("test");
        Runtime.getRuntime().addShutdownHook(new Thread(
                () -> {
                    try {
                        while (true) {
                            logger.info("logger wait");
                            System.out.println("print wait");
                            Thread.sleep(1000);
                        }
                    } catch (Exception e) {
                        logger.info("logger error");
                        System.out.println("print error");
                        System.exit(1);
                    }
                }
        ));
    }
}

上記を実行実行すると、下記のような実行結果となります。

11 02, 2023 12:07:18 午前 org.example.Main main
情報: test
11 02, 2023 12:07:18 午前 org.example.Main lambda$main$0
情報: logger wait
print wait
print wait
print wait
print wait
print wait
print wait

Comments

[退会済みユーザー]

古いので今も有効か確認していませんが。。。
https://stackoverflow.com/questions/13825403/java-how-to-get-logger-to-work-in-shutdown-hook#answer-13825590

Answer 1

シャットダウン中なら何があっても不思議では無いというのが前提かと思います。JPCERT にも以下の指摘があります。

FIO14-J. プログラムの終了時には適切なクリーンアップを行う 2012-01

シャットダウン時にはJVMがセンシティブな状態にあるかもしれないので、いくつか注意すべき事項がある。シャットダウンフックは以下の条件を満たすべきである。

処理に時間がかからず簡潔であること
スレッドセーフであること
データアクセス時にはロックを取得し、アクセスが完了したらロックを解放すること
システムのサービスに依存しないこと。サービス自身もシャットダウンするかもしれない(たとえば、ロガーはその他のフックによって終了するかもしれない)