お世話になります。
昨日、全仮想HUB(87個)でSecureNATが再起動したような挙動を確認しました。
以下のログが出力されていました。
2024-06-17 12:04:03.937 SecureNAT が開始されました。SecureNAT セッション "SID-SECURENAT-1" を作成しました。
タイミングは日時分秒まで同じで、ミリ秒だけ違っていたため一斉に開始されたとみています。
サービス再起動の場合、先述のログの前に「SecureNAT が停止しました。」というログが出力されるかと存じますが、今回は出力されていませんでした。
原因は何が考えられるでしょうか。
以下の製品を使用しています。
<製品名>SoftEther VPN Server (64bit) (Open Source)
<バージョン情報>Version 4.22 Build 9634 (Japanese)
よろしくお願いいたします。
SecureNATの挙動について
-
- Site Admin
- Posts: 2207
- Joined: Sat Mar 09, 2013 5:37 am
Re: SecureNATの挙動について
正常であれば、原因となった他のログも近い時刻で記録されていると思います。
サーバーログを確認してみてください。
サーバーログを確認してみてください。
-
- Posts: 14
- Joined: Mon Dec 03, 2018 5:53 am
Re: SecureNATの挙動について
ご返信ありがとうございます。
サーバーログを確認しましたが、以下のように特段エラーはありませんでした。
2024-06-17 12:03:54.129 [HUB "aaaaaa"] SecureNAT: UDP セッション 3110 が作成されました。接続元 192.168.216.17:51595, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.230 [HUB "bbbbbb"] SecureNAT: UDP セッション 2373 が削除されました。
2024-06-17 12:03:54.446 [HUB "cccccc"] SecureNAT: UDP セッション 2474 が削除されました。
2024-06-17 12:03:54.700 [HUB "dddddd"] SecureNAT: UDP セッション 1723 が作成されました。接続元 192.168.216.13:53160, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.700 [HUB "dddddd"] SecureNAT: UDP セッション 1724 が作成されました。接続元 192.168.216.13:53162, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.740 [HUB "cccccc"] SecureNAT: UDP セッション 2482 が作成されました。接続元 192.168.216.20:138, 接続先 255.255.255.255:138
2024-06-17 12:03:54.801 [HUB "eeeeee"] SecureNAT: UDP セッション 689 が削除されました。
2024-06-17 12:04:03.623 ------------------------------------------------------
2024-06-17 12:04:03.623 SoftEther VPN Server Version 4.22 Build 9634 (Japanese)
2024-06-17 12:04:03.623 Compiled 2016/11/27 14:33:59 by yagi at pc30
2024-06-17 12:04:03.623 Log Messages are written with UTF-8 Encoding Format.
2024-06-17 12:04:03.623 SoftEther VPN Server エンジンを起動しました。
2024-06-17 12:04:03.623 IPsec モジュール: IPsec ver 2.0 (ISAKMP/IKEv1) 処理モジュールを起動しました。
2024-06-17 12:04:03.623 OpenVPN モジュール: OpenVPN サーバーモジュールを起動しました。
2024-06-17 12:04:03.623 設定ファイルの読み込みを行います。
2024-06-17 12:04:03.826 ディレクトリ "/xxxxx/vpnserver" の監視を開始します。ディスクの空き容量が 100.00 MBytes 未満になった場合、このディレクトリのサブディレクトリ内に保存されているログファイルおよび設定のバックアップファイルを、古い順番に自動的に削除します。削除を開始するディスクの最小空き容量は、設定ファイルの "AutoDeleteCheckDiskFreeSpaceMin" 項目で変更することができます。
2024-06-17 12:04:03.826 仮想 HUB "ffffff" を開始しました。
2024-06-17 12:04:03.826 仮想 HUB "ffffff" の MAC アドレスは "xx-xx-xx-xx-xx-xx" です。
2024-06-17 12:04:03.836 [HUB "ffffff"] SecureNAT が開始されました。SecureNAT セッション "SID-SECURENAT-1" を作成しました。
2024-06-17 12:04:03.836 [HUB "ffffff"] 仮想 HUB がオンラインになりました。
サーバーログを確認しましたが、以下のように特段エラーはありませんでした。
2024-06-17 12:03:54.129 [HUB "aaaaaa"] SecureNAT: UDP セッション 3110 が作成されました。接続元 192.168.216.17:51595, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.230 [HUB "bbbbbb"] SecureNAT: UDP セッション 2373 が削除されました。
2024-06-17 12:03:54.446 [HUB "cccccc"] SecureNAT: UDP セッション 2474 が削除されました。
2024-06-17 12:03:54.700 [HUB "dddddd"] SecureNAT: UDP セッション 1723 が作成されました。接続元 192.168.216.13:53160, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.700 [HUB "dddddd"] SecureNAT: UDP セッション 1724 が作成されました。接続元 192.168.216.13:53162, 接続先 255.255.255.255:1900
2024-06-17 12:03:54.740 [HUB "cccccc"] SecureNAT: UDP セッション 2482 が作成されました。接続元 192.168.216.20:138, 接続先 255.255.255.255:138
2024-06-17 12:03:54.801 [HUB "eeeeee"] SecureNAT: UDP セッション 689 が削除されました。
2024-06-17 12:04:03.623 ------------------------------------------------------
2024-06-17 12:04:03.623 SoftEther VPN Server Version 4.22 Build 9634 (Japanese)
2024-06-17 12:04:03.623 Compiled 2016/11/27 14:33:59 by yagi at pc30
2024-06-17 12:04:03.623 Log Messages are written with UTF-8 Encoding Format.
2024-06-17 12:04:03.623 SoftEther VPN Server エンジンを起動しました。
2024-06-17 12:04:03.623 IPsec モジュール: IPsec ver 2.0 (ISAKMP/IKEv1) 処理モジュールを起動しました。
2024-06-17 12:04:03.623 OpenVPN モジュール: OpenVPN サーバーモジュールを起動しました。
2024-06-17 12:04:03.623 設定ファイルの読み込みを行います。
2024-06-17 12:04:03.826 ディレクトリ "/xxxxx/vpnserver" の監視を開始します。ディスクの空き容量が 100.00 MBytes 未満になった場合、このディレクトリのサブディレクトリ内に保存されているログファイルおよび設定のバックアップファイルを、古い順番に自動的に削除します。削除を開始するディスクの最小空き容量は、設定ファイルの "AutoDeleteCheckDiskFreeSpaceMin" 項目で変更することができます。
2024-06-17 12:04:03.826 仮想 HUB "ffffff" を開始しました。
2024-06-17 12:04:03.826 仮想 HUB "ffffff" の MAC アドレスは "xx-xx-xx-xx-xx-xx" です。
2024-06-17 12:04:03.836 [HUB "ffffff"] SecureNAT が開始されました。SecureNAT セッション "SID-SECURENAT-1" を作成しました。
2024-06-17 12:04:03.836 [HUB "ffffff"] 仮想 HUB がオンラインになりました。
-
- Site Admin
- Posts: 2207
- Joined: Sat Mar 09, 2013 5:37 am
Re: SecureNATの挙動について
「SoftEther VPN Server エンジンを起動しました。」というログが出ているので、サーバーが再起動したと思われます。
その前に終了のログが出ていないので、強制終了させられたようですね。
その前に終了のログが出ていないので、強制終了させられたようですね。
-
- Posts: 14
- Joined: Mon Dec 03, 2018 5:53 am
Re: SecureNATの挙動について
ご確認ありがとうございます。
どのようなときに強制終了させられるのでしょうか。
どのようなときに強制終了させられるのでしょうか。
-
- Site Admin
- Posts: 2207
- Joined: Sat Mar 09, 2013 5:37 am
Re: SecureNATの挙動について
バグによるクラッシュもありえますし、ハードウェアの異常で実行を継続できなかったり、メモリが足りなくなってOSに強制終了させられる場合もあります。