haproxyのアクセスログを確認して画面遅延の機能の特定をしたい

以下のようなログがあります。

Apr 18 00:13:06 localhost haproxy[19224]: 192.168.1.77:53780 [18/Apr/2019:00:13:06.501] frontend_xxx xxx_servers/xxx_servers2 4/0/0/155/160 200 6764 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/1168/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"

やりたいこととしては上記のログでいう
「155」「1168」
という値が画面の読み込みにかかった時間(ミリ秒)のようですので
「この時間順にログを降順に並び変えたい」
ということになります。

既に前回の質問から
「どれくらいの秒数のリクエストがどれくらいあるか？」
についてはシェルで解決できたのですが今度は一歩進んで
「そのリクエストは何なのか？」
を特定したく質問させて頂きました。

宜しくお願い致します。

行動規範の内容に同意します

回答1件

ベストアンサー

haproxyを触ったことがないですが、「155」「1168」の部分のソートであれば下記のワンライナーで解決できると思います。

bash
1$ cat log_file | sort -nr -t '/' -k7,7
2Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/1168/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
3Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/300/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
4Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/200/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
5Apr 18 00:13:06 localhost haproxy[19224]: 192.168.1.77:53780 [18/Apr/2019:00:13:06.501] frontend_xxx xxx_servers/xxx_servers2 4/0/0/155/160 200 6764 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"

ログをlog_fileというファイルに保存しており、またデータが２行と少なかったので「200」と「300」のログを追加しています。
catの部分を変更すれば標準入力も処理できます。

またhaproxyについて詳しくないで間違っているかもしれないですが、
もし「xxx_servers/xxx_servers2」の部分などが「xxx_servers/xxx_servers2/aaa」のように「/」の数が増減する場合だと上記のコードでは処理できません。

その場合は冗長ですが下記のコードで処理できます。

bash
1$ cat log_file | awk '{print $10,$0}' | sort -nr -t '/' -k4,4 | cut -d ' ' -f 2-
2Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/1168/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
3Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/300/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
4Apr 18 00:14:07 localhost haproxy[19224]: 192.168.1.77:53821 [18/Apr/2019:00:14:06.487] frontend_nxxx xxx_servers/xxx_servers2 3/0/0/200/1171 200 6754 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"
5Apr 18 00:13:06 localhost haproxy[19224]: 192.168.1.77:53780 [18/Apr/2019:00:13:06.501] frontend_xxx xxx_servers/xxx_servers2 4/0/0/155/160 200 6764 - - --NI 2/2/0/0/0 0/0 "GET /login HTTP/1.1"