フォーラム：00_インストール・設定
tomcat停止
|
[ 4535 ] tomcat停止
以下の環境でGS3を運用・管理しています。
DTI社のVPSサービスを利用。
・OS Linux i386 2.6.32-042stab044.11
・J2EEコンテナ Apache Tomcat/6.0.32
・Java 1.6.0_24 Sun Microsystems Inc.
・メモリ使用 249,697KB (98.5%)
・メモリ最大 253,440KB
・現在の空きディスク容量 28773MB
現象：Tomcatの断続的な停止 => tomcatの再起動でGS3にはアクセス出来るようになるがまた断絶してしまう。
以下のログがcatalina.outで表示されています。
2012/01/26 9:16:48 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/26 14:22:42 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/28 23:02:44 org.apache.coyote.http11.Http11Protocol pause
情報: Coyote HTTP/1.1を http-8080 で一時停止します
2012/01/28 23:02:44 org.apache.catalina.connector.Connector pause
致命的: プロトコルハンドラの一時停止に失敗しました
java.net.SocketException: Network is unreachable
DTI社との契約はメモリーが512MBとなっているためtomcatに割り当てているメモリーは256MBに設定しています。また1月28日にVPSのメンテが発生しサーバーも数時間停止したようです。
原因とその対策をご教示願います。
投稿者nobby 最新書き込み2012/01/30 10:33:08
|
[ 4536 ] Re: tomcat停止
＞警告: processCallbacks status 2
は想定外のリクエストが送られて処理が追いつかずにタイムアウトする際に発生するようです。
とりあえずtomcatのポートのタイムアウト時間を伸ばすことをやってみるとか。
ただメモリが推奨環境以下なので、メモリを増やすことが先のような気がしますが。
投稿者test 最新書き込み2012/01/30 15:01:45
|
[ 4538 ] Re: tomcat停止
もっと手前にエラーが出てると思うんだが……
本当にエラーはそれだけなのですか？
投稿者ふぁんぐす 最新書き込み2012/01/30 16:36:14
|
[ 4540 ] Re: Re: tomcat停止
> ＞警告: processCallbacks status 2
> は想定外のリクエストが送られて処理が追いつかずにタイムアウトする際に発生するようです。
> とりあえずtomcatのポートのタイムアウト時間を伸ばすことをやってみるとか。
>
> ただメモリが推奨環境以下なので、メモリを増やすことが先のような気がしますが。
ご指摘の通り推奨するメモリー容量を下回っていますね。早速1GBへの増設を依頼中です。有難うございます。
投稿者nobby 最新書き込み2012/01/30 22:27:03
|
[ 4541 ] Re: Re: tomcat停止
> もっと手前にエラーが出てると思うんだが……
> 本当にエラーはそれだけなのですか？
再度ログをあたってみます。
投稿者nobby 最新書き込み2012/01/30 22:28:20
|
[ 4543 ] Re: Re: tomcat停止
> もっと手前にエラーが出てると思うんだが……
> 本当にエラーはそれだけなのですか？
先のログより少し前に出力されているログを書きます。
2012/01/14 9:09:12 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/14 15:15:50 org.apache.tomcat.util.http.Parameters processParameters
警告: Parameters: Invalid chunk '' ignored.
2012/01/16 7:56:50 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/16 16:20:01 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/18 9:31:27 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/18 10:18:28 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/18 10:32:20 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/19 7:40:46 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/19 10:38:20 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/24 9:33:03 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/24 9:33:07 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/24 16:21:33 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/24 16:21:37 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/24 16:42:17 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/25 8:51:19 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
2012/01/25 9:00:17 org.apache.jk.common.ChannelSocket processConnection
警告: processCallbacks status 2
投稿者nobby 最新書き込み2012/01/31 08:04:44
|
[ 4544 ] Re: tomcat停止
Groupsessionのエラーログも掲示します。
(BasicDataSource.java:851)
... 6 more
2012-01-31 08:05:21,131 ERROR jp.co.sjts.util.jdbc.JDBCUtil: - コネクションの取得に失敗(2回目)
org.apache.commons.dbcp.SQLNestedException: Cannot create PoolableConnectionFactory (データベースが使用中です: "Locked by another process". 可能な解決策: 他の接続を全て閉じる; サーバモードを使う
Database may be already in use: "Locked by another process". Possible solutions: close all other connection(s); use the server mode; SQL statement:
null/1352c28c12ef6261760beb79e038fb6e81e395c0fa7 [90020-147])
at org.apache.commons.dbcp.BasicDataSource.createDataSource(BasicDataSource.java:855)
at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:540)
at jp.co.sjts.util.jdbc.JDBCUtil.getConnection(JDBCUtil.java:445)
at jp.co.sjts.util.jdbc.JDBCUtil.getConnection(JDBCUtil.java:401)
at jp.groupsession.v2.cmn.quartz.AbstractJob.execute(AbstractJob.java:98)
at org.quartz.core.JobRunShell.run(JobRunShell.java:202)
at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:529)
Caused by: org.h2.jdbc.JdbcSQLException: データベースが使用中です: "Locked by another process". 可能な解決策: 他の接続を全て閉じる; サーバモードを使う
Database may be already in use: "Locked by another process". Possible solutions: close all other connection(s); use the server mode; SQL statement:
投稿者nobby 最新書き込み2012/01/31 08:37:44
|
[ 4548 ] Re: tomcat停止
技術的な厳密さでいうと間違っているかもしれませんが、２つ問題があるのでは？
(1)メモリ不足から重い処理を行う場合にエラーになる、場合によってはシステムが止まる
これは、メモリを増設して適切に設定すれば、改善されると思います。
(2)28日にメンテをしたと書いてあり、その後現象が起こっているのなら、正常にシャットダウンしなかった等でTomcatのシステムが一部おかしな状態になっていると思われます。対処だけを考えるなら、各種の設定・キャッシュ等が残らないように完全にクリーンな状態にアンストールしてから、tomcatとGSを最初からインストールするのが良いのでは？
投稿者00 最新書き込み2012/01/31 15:58:52
|
[ 4549 ] Re: tomcat停止
止まる原因は不明ですが、
＞2012/01/28 23:02:44 org.apache.coyote.http11.Http11Protocol pause
＞情報: Coyote HTTP/1.1を http-8080 で一時停止します
で異常終了して、ポートを塞いだまま？になっているので、
＞2012/01/28 23:02:44 org.apache.catalina.connector.Connector pause
＞致命的: プロトコルハンドラの一時停止に失敗しました
＞java.net.SocketException: Network is unreachable
tomcatが自分で再度起動しようとしても動かない。正常終了させたら、起動して・・・以下繰り返しという事ではないかと
投稿者00 最新書き込み2012/01/31 16:08:32
|
[ 4554 ] Re: Re: tomcat停止
> 技術的な厳密さでいうと間違っているかもしれませんが、２つ問題があるのでは？
>
> (1)メモリ不足から重い処理を行う場合にエラーになる、場合によってはシステムが止まる
> これは、メモリを増設して適切に設定すれば、改善されると思います。
Tomcatが使えるmemoryを増やしましたが現象が再現しています。Tomcatの再起動で接続するときもあるがほどなくtomcatが停止する。
・メモリ使用 1,097,389KB (54.1%)
TomcatとGSの再導入が一番はやいのでしょうか？
本日の最新もtomcatのログです。
2012/02/01 9:11:18 org.apache.catalina.startup.HostConfig deployWAR
: Web gsession3.war
log4j:WARN No appenders could be found for logger (jp.groupsession.v2.cmn.GroupSession).
log4j:WARN Please initialize the log4j system properly.
2012/02/01 9:11:27 org.apache.catalina.startup.HostConfig deployDirectory
: Web docs
2012/02/01 9:11:27 org.apache.catalina.startup.HostConfig deployDirectory
: Web examples
2012/02/01 9:11:28 org.apache.catalina.startup.HostConfig deployDirectory
: Web ROOT
2012/02/01 9:11:28 org.apache.coyote.http11.Http11Protocol start
: Coyote HTTP/1.1 http-8080
2012/02/01 9:11:28 org.apache.jk.common.ChannelSocket init
: JK: ajp13 listening on /0.0.0.0:8009
2012/02/01 9:11:28 org.apache.jk.server.JkMain start
: Jk running ID=0 time=0/28 config=null
2012/02/01 9:11:28 org.apache.catalina.startup.Catalina start
: Server startup in 9961 ms
#
# A fatal error has been detected by the Java Runtime Environment:
#
# Internal Error (synchronizer.cpp:1954), pid=1314, tid=305249168
# guarantee(mid->header()->is_neutral()) failed: invariant
#
# JRE version: 6.0_24-b07
# Java VM: Java HotSpot(TM) Client VM (19.1-b02 mixed mode linux-x86 )
# An error report file with more information is saved as:
# /home/.users/112/admin/hs_err_pid1314.log
投稿者nobby 最新書き込み2012/02/01 09:26:43
|
[ 4556 ] Re: Re: Re: tomcat停止
サーバーの free コマンドの結果はどうなっていますか？
投稿者hogeinia 最新書き込み2012/02/01 11:03:32
|
[ 4557 ] Re: Re: Re: Re: tomcat停止
hogeiniaさん
> サーバーの free コマンドの結果はどうなっていますか？
以下のように十分な容量です。
よろしくお願いします。
total used free shared buffers cached
Mem: 4096 2849 1246 0 0 320
-/+ buffers/cache: 2529 1566
Swap: 0 0 0
Total: 4096 2849 1246
投稿者nobby 最新書き込み2012/02/01 11:10:13
|
[ 4559 ] Re: Re: Re: Re: Re: tomcat停止
うちもVPS（某社）なんですが、こんな感じです。
# free -tm
total used free shared buffers cached
Mem: 2048 1329 718 0 0 0
-/+ buffers/cache: 1329 718
Swap: 0 0 0
Total: 2048 1329 718
メモリ2Gで1.3G程度の利用率。うちのよりも全然余裕有りますよね。
tomcatのメモリ割り当ては、-Xmx512M -Xms128M といった感じ。
javaとtomcatのバージョンの問題かも？と思い見てみましたが、
うちのも全く同じバージョンでした。
・J2EEコンテナ Apache Tomcat/6.0.32
・Java 1.6.0_24 Sun Microsystems Inc.
・メモリ使用 339,934KB (67.1%)
・メモリ最大 506,816KB
・現在の空きディスク容量 41091MB
# Internal Error (synchronizer.cpp:1954), pid=1314, tid=305249168
# guarantee(mid->header()->is_neutral()) failed: invariant
このメッセージで検索しても、日本語ページは見つからないですね…。
うーーん、お役に立てそうにないです。申し訳ない。
投稿者hogeinia 最新書き込み2012/02/01 13:48:14
|
[ 4560 ] Re: tomcat停止
エラーメッセージにある、下記ファイルの中身はどうなってます？
/home/.users/112/admin/hs_err_pid1314.log
投稿者スタバ 最新書き込み2012/02/01 13:55:11
|
[ 4561 ] Re: Re: tomcat停止
スタバさん コメント有難うございます。
>
エラーメッセージにある、下記ファイルの中身はどうなってます？
> /home/.users/112/admin/hs_err_pid1314.log
以下header部分のみまずはコピーして掲示します。
-----
#
# A fatal error has been detected by the Java Runtime Environment:
#
# Internal Error (synchronizer.cpp:1954), pid=1314, tid=305249168
# guarantee(mid->header()->is_neutral()) failed: invariant
#
# JRE version: 6.0_24-b07
# Java VM: Java HotSpot(TM) Client VM (19.1-b02 mixed mode linux-x86 )
# If you would like to submit a bug report, please visit:
# http://java.sun.com/webapps/bugreport/crash.jsp
#
--------------- T H R E A D ---------------
Current thread (0x096da400): VMThread [stack: 0x1229b000,0x1231c000] [id=1316]
よろしくお願いいたします。
投稿者nobby 最新書き込み2012/02/01 15:19:42
|
[ 4562 ] Re: tomcat停止
GS３との事ですが、詳細なバージョンはいくつでしょうか？
バージョン3.0.0, 3.0.1には、DBまわりに致命的なバグがあるとの事。
http://gsession.blog69.fc2.com/blog-date-201007.html
投稿者hogeinia 最新書き込み2012/02/01 15:28:40
|
[ 4563 ] Re: Re: tomcat停止
hogeiniaさん お世話になっています。
> GS３との事ですが、詳細なバージョンはいくつでしょうか？
>
> バージョン3.0.0, 3.0.1には、DBまわりに致命的なバグがあるとの事。
> http://gsession.blog69.fc2.com/blog-date-201007.html
>
3.1.0を使用しています。
ところで本日10時半以降は断絶もなく稼働しております。つきましてはtomcatやGS3の再導入作業は
もう少し様子を見てからにしてみようと思っているところです。
投稿者nobby 最新書き込み2012/02/01 15:42:28
|
[ 4568 ] Re: Re: Re: tomcat停止
> ところで本日10時半以降は断絶もなく稼働しております。つきましてはtomcatやGS3の再導入作業は
> もう少し様子を見てからにしてみようと思っているところです。
2月1日~2月2日までトラブルなしで運用できています。今回はTomcatやGS3などの入れ替えは行わず、次回また同様のトラブルが発生した場合はご助言いただいた内容に沿い、作業してみる予定です。
コメント、回答いただいた方有難うございました。
投稿者nobby 最新書き込み2012/02/02 17:19:01
|