遅い処理を特定する手順（syslog_transaction）

「なんだかシステムが重い」「さっきの画面がやたら遅かった」。運用をしていると、こういう曖昧な訴えが飛んできます。困るのは、何をもって「遅い」と言っているのかが、報告の時点では分からない点です。体感は人によってばらつき、再現もしにくい。ここで勘に頼って設定をいじり始めると、たいてい遠回りになります。

ServiceNow には、この「重い・遅い」を数字で確かめられる記録が最初から用意されています。Transaction log（テーブル名 syslog_transaction）です。誰が、いつ、どの画面やAPIを開き、その処理に何ミリ秒かかったか。1リクエストごとに1行、淡々と積み上がっています。遅い処理の特定は、この記録を並べ替えて絞り込むだけの機械的な作業になります。

PDI（Zurich / OOTB）の実レコードで、その並べ替えと絞り込みを実際にやってみました。無料部は Transaction log の全体像と、遅い順に並べたときに何が出てくるか。有料部は、調査で打つ絞り込みクエリと、実機で取れた内訳の数字です。「重い」という曖昧な報告を、原因の当たりがつく事実へ変換するところまで扱います。

Transaction log とは：全リクエストの処理時間の記録

Transaction log は、インスタンスが処理した1件ごとのリクエストを記録するテーブルです。フォームを開いた、一覧を絞り込んだ、REST APIを叩いた、スケジュールジョブが動いた。その一つひとつに対して、URL・種類（type）・処理時間（response_time）・実行者などが1行に残ります。

PDI で実際に件数を数えると、syslog_transaction は全部で 53,295 件ありました。このうち処理時間が1秒（1000ミリ秒）を超えたものは 30,371 件。全体の半分以上が「1秒超」に該当します。もっとも、そのほとんどは人が待っているわけではない裏側のジョブなので、数字の大きさだけで慌てる必要はありません。この記録があれば、「遅い処理」を件数と時間で客観的に並べられます。

一番の主役は response_time という列です。単位はミリ秒。この1列を降順に並べるだけで、インスタンスの中で何が一番時間を食っているかが、上から順に見えてきます。調査の出発点は、いつもここになります。

この記録に特別な準備は要りません。ログ出力を仕込んだり、設定を有効化したりしなくても、Transaction log は最初から動いています。障害の連絡を受けてから慌てて計測を始める必要はなく、すでに積み上がった記録をあとからさかのぼれます。事後でも間に合う、というわけです。ただし古い記録は順次消えていくため、気づいたら早めに見ておきます。

まず遅い順に並べる

やることは拍子抜けするほど単純です。Transaction log の一覧を開き、response_time で降順（大きい順）に並べ替える。これだけ。この一手で「遅い処理ランキング」ができあがります。

実機で並べると、先頭に来たのは「JOB: BackgroundProgressJob」という処理で、その response_time はおよそ 3,589,895ミリ秒。秒に直すと約60分です。次いで「JOB: Compaction Qualification Job」が約1,120,330ミリ秒（約19分）と続きました。いずれも人が画面で待っていたものではありません。裏で回るバックグラウンドのジョブでした。フォーム操作の最遅は約50,311ミリ秒（約50秒）で、UI Policy の設定画面を開いたときの記録です。

ここで分かるのは、遅い処理には「種類」がある、ということ。裏のジョブが遅いのか、人が開いた画面が遅いのか、API連携が遅いのか。これを見分けるのが type という列で、次の絞り込みで効いてきます。

調査は6ステップで回す

遅い処理の調査は、行き当たりばったりだと疲れます。あちこち開いては戻り、時間だけが過ぎていく。順番をあらかじめ決めておけば、毎回同じ手つきで原因の当たりまでたどり着けます。踏むのは次の6ステップです。

まず response_time で遅い順に並べ、1秒超で母数を絞る。次に type と url で「どの種類のどの処理か」を特定する。そこから内訳の列を使って「時間をどこで使ったのか」を分解し、同じ時刻の System Log（syslog）と突き合わせる。最後に実行ユーザーやセッションで、同じ操作をひとまとめに追う。ここまで来ると、「DBが重い」「特定のスクリプトが重い」「混雑して待たされた」といった原因の方向が見えてきます。

有料部では、各ステップで実際に打つ絞り込みクエリと、実機で取れた内訳の数字を並べます。「遅い」を「なぜ遅いか」に変えるところまで、具体例で進みます。