rails的log分析工具

 wvanbergen-request-log-analyzer (0.1.2)

 

http://github.com/wvanbergen/request-log-analyzer/tree/master#

 

1. Request log analyzer
2. --------------------------------
4. This is a simple command line tool to analyze request log files of both Rails and
5. Merb. Its purpose is to find what actions are best candidates for optimization.
7. This tool will parse all requests in the logfile and aggregate the
8. information. Once it is finished parsing the log file, it will show the
9. requests that take op most server time. Different metrics are used (cumulative
10. time, average time, blockers, DB time, etc)
13. Installation
14. --------------------------------
15. gem sources -a http://gems.github.com
16. sudo gem install wvanbergen-request-log-analyzer
18. Usage
19. --------------------------------
21. Usage: request-log-analyzer [FILE] [OPTION]
22. Analyze the given log FILE with the given OPTION
23. Example: request-log-analyzer mongrel.log
25.   --fast, -t:                 Only use completed requests
26.   --guess-database-time, -g:  Guesses the database duration of requests if they are not in the log
27.   --output, -o:               Comma-separated list of reports to show    
28.   --amount, -c:               Displays the top <amount> elements in the reports
29.   --colorize, -z:             Fancy bash coloring
33. Example
34. --------------------------------
36. Note that this example was shortened for your viewing pleasure.
37. $ request-log-analyzer /var/log/my_app.log
39. Request log analyzer, by Willem van Bergen and  Bart ten Brinke
41. Processing all log lines...
42. ========================================================================
43. Successfully analyzed 58908 requests from log file
45. Timestamp first request: 2008-07-13T06:25:58+00:00
46. Timestamp last request:  2008-07-20T06:18:53+00:00
47. Total time analyzed: 7 days
48. Methods: DELETE (1%), GET (50%), POST (22%), PUT (25%).
50. Top 10 most requested actions
51. ========================================================================
52. /overview/:date/                                  : 19359 requests
53. /overview/day/:date/                              : 6365 requests
54. /overview/:date/set/                              : 5589 requests
55. /overview/                                        : 3985 requests
56. /clients/:id/                                     : 1976 requests
57. ........
59. Top 10 actions by time - cumulative
60. ========================================================================
61. /overview/:date/                                  :   9044.582s [19359 requests]
62. /overview/                                        :   8478.767s [3985 requests]
63. /overview/:date/set/                              :   3309.041s [5589 requests]
64. /clients/:id/products/:id/                        :   1479.911s [924 requests]
65. /clients/:id/                                     :    750.080s [1976 requests]
66. ........
68. Top 10 actions by time - per request mean
69. ========================================================================
70. /overview/                                        :      2.128s [3985 requests]
71. /clients/:id/products/:id/                        :      1.602s [924 requests]
72. /overview/:date/set/                              :      0.592s [5589 requests]
73. /overview/:date/                                  :      0.467s [19359 requests]
74. /clients/:id/                                     :      0.380s [1976 requests]
75. ........
77. Top 10 worst DB offenders - cumulative time
78. ========================================================================
79. /overview/:date/                                  :   8773.993s [19359 requests]
80. /overview/                                        :   8394.754s [3985 requests]
81. /overview/:date/set/                              :   3307.928s [5589 requests]
82. /clients/:id/products/:id/                        :   1425.220s [924 requests]
83. /clients/:id/                                     :    535.229s [1976 requests]
84. ........
86. Top 10 worst DB offenders - mean time
87. ========================================================================
88. /overview/:id/:id/:id/print/                      :      6.994s [448 requests]
89. /overview/                                        :      2.128s [3985 requests]
90. /clients/:id/products/:id/                        :      1.602s [924 requests]
91. /overview/:date/set/                              :      0.592s [5589 requests]
92. /overview/:date/                                  :      0.467s [19359 requests]
93. ........
95. Mongrel process blockers (> 1.0 seconds)
96. ========================================================================
97. /overview/:date/                                  :   7494.233s [3144 requests]
98. /overview/                                        :   8320.293s [1549 requests]
99. /overview/:date/set/                              :   1149.235s [803 requests]
100. /overview/:id/:id/:id/print/new/                  :    613.693s [341 requests]
101. /clients/:id/products/:id/                        :   1370.693s [313 requests]
102. ........
104. Requests graph - per hour
105. ========================================================================
106.          ........
107.          7:00 - 2731                 : XXXXXXX
108.          8:00 - 6139                 : XXXXXXXXXXXXXXXX
109.          9:00 - 7465                 : XXXXXXXXXXXXXXXXXXXX
110.         10:00 - 7118                 : XXXXXXXXXXXXXXXXXXX
111.         11:00 - 7409                 : XXXXXXXXXXXXXXXXXXX
112.         12:00 - 6450                 : XXXXXXXXXXXXXXXXX
113.         13:00 - 5377                 : XXXXXXXXXXXXXX
114.         14:00 - 6058                 : XXXXXXXXXXXXXXXX
115.         15:00 - 4156                 : XXXXXXXXXXX
116.         16:00 - 2767                 : XXXXXXX
117.         17:00 - 1598                 : XXXX
118.         18:00 - 792                  : XX
119.         ........
121. Errors
122. ========================================================================
123. ArgumentError: [237 requests]
124.  -> invalid date
125. StaleObjectError: [28 requests]
126.  -> Attempted to update a stale object
127. RuntimeError: [3 requests]
128.  -> Cannot destroy rule before it was created
129. StatementError: [2 requests]
130.  -> Mysql::Error: Deadlock found when trying to get lock; try restarting transaction
131. NoMethodError: [1 requests]
132.  -> undefined method `code' for nil:NilClass