T R A C K 2 S Q L
-----------------------------
a server log analysis tool
TRACK2SQL IS PROVIDED "AS IS", WITHOUT A WARRANTY OF ANY
KIND. ALL EXPRESS OR IMPLIED REPRESENTATIONS AND WARRANTIES,
INCLUDING ANY IMPLIED WARRANTY OF MERCHANTABILITY, FITNESS
FOR A PARTICULAR PURPOSE, OR NON-INFRINGEMENT, ARE HEREBY
EXCLUDED.
Description
Track2sql takes a VTRACK log file (server version 2005.2 or
greater) as input, and produces an SQL file as output. It
requires a PHP command-line interpreter and an SQL database.
It has been tested with PHP version 5, but might be compatible
with earlier versions. It has been tested with MySQL version 5
but should be compatible with other SQL databases.
Usage
php track2sql.php [ logFile | - [ sqlFile | - ] ] [ -d dbName ]
Options:
logFile name of input file or '-' for stdin
sqlFile name of output file or '-' for stdout
-d name of database to create
Examples:
$ track2sql.php log track.sql -d track
$ cat log | track2sql.php | mysql
$ tail -F log | track2sql.php | mysql
Application
The power of SQL allows us to analyze the server log data in
many different ways. In particular, track2sql is an effective
tool for identifying performance problems. If you are
experiencing poor performance, try the following steps to
illuminate the culprits.
1. Convert your log file to sql.
track2sql.php logFile -d dbName | mysql
2. Launch your SQL client
mysql dbName
3. Identify commands with long compute-phases.
mysql> SELECT
process.processKey,user,cmd,
MAX(readHeld+writeHeld)-MAX(readWait+writeWait)
AS compute
FROM tableUse JOIN process USING (processKey)
GROUP BY tableUse.processKey
ORDER BY compute DESC LIMIT 25;
This will produce a list of 25 processes that held locks
on one or more database tables for an extended period
of time. During these periods of time, it is possible
that the offending processes blocked other processes,
thereby degrading performance.
+------------+------+-----------+---------+
| processKey | user | cmd | compute |
+------------+------+-----------+---------+
| 12345 | jdoe | user-sync | 98765 |
| ... | ... | ... | ... |
+------------+------+-----------+---------+
FOR EACH OFFENSIVE PROCESS:
a. Get process information.
mysql> SELECT * FROM process
WHERE processKey=12345;
b. Get table usage information.
mysql> SELECT * FROM tableUse
WHERE processKey=12345;
c. Identify bottlenecks and take action.
This last step can be difficult. Keep in mind that
in general, performance can be improved three ways:
-> By improving hardware (memory, disks, cpu)
-> By upgrading software (perforce server/clients, OS)
-> By adjusting usage (reducing scope of commands)
Schema
+------------+---------------+------+-----+
| P R O C E S S |
+------------+---------------+------+-----+
| Field | Type | Null | Key |
+------------+---------------+------+-----+
| processKey | int(11) | NO | PRI |
| time | int(11) | NO | |
| pid | int(11) | NO | |
| user | varchar(255) | NO | |
| client | varchar(255) | NO | |
| ip | varchar(255) | NO | |
| app | varchar(255) | NO | |
| cmd | varchar(255) | NO | |
| args | text | YES | |
| lapse | decimal(10,3) | YES | |
| uCpu | int(11) | YES | |
| sCpu | int(11) | YES | |
| diskIn | int(11) | YES | |
| diskOut | int(11) | YES | |
| ipcIn | int(11) | YES | |
| ipcOut | int(11) | YES | |
| maxRss | int(11) | YES | |
| pageFaults | int(11) | YES | |
| rpcMsgsIn | int(11) | YES | |
| rpcMsgsOut | int(11) | YES | |
| rpcSizeIn | int(11) | YES | |
| rpcSizeOut | int(11) | YES | |
+------------+---------------+------+-----+
+-------------+--------------+------+-----+
| T A B L E U S E |
+-------------+--------------+------+-----+
| Field | Type | Null | Key |
+-------------+--------------+------+-----+
| processKey | int(11) | NO | PRI |
| tableName | varchar(255) | NO | PRI |
| pagesIn | int(11) | YES | |
| pagesOut | int(11) | YES | |
| pagesCached | int(11) | YES | |
| readLocks | int(11) | YES | |
| writeLocks | int(11) | YES | |
| getRows | int(11) | YES | |
| posRows | int(11) | YES | |
| scanRows | int(11) | YES | |
| putRows | int(11) | YES | |
| delRows | int(11) | YES | |
| readWait | int(11) | YES | |
| readHeld | int(11) | YES | |
| writeWait | int(11) | YES | |
| writeHeld | int(11) | YES | |
+-------------+--------------+------+-----+
| # | Change | User | Description | Committed | |
|---|---|---|---|---|---|
| #1 | 6254 | Harold S. MacKiernan | pulling over current version of track2sql for porting | ||
| //guest/stewart_lord/track2sql/README | |||||
| #3 | 5889 | Stewart Lord |
Modified create table statements to use signed columns instead of unsigned columns. This avoids subtraction problems that can occur in some versions of MySQL when SQL_MODE is not set to NO_UNSIGNED_SUBTRACTION. Main() now sets error_reporting to E_ALL & ~E_NOTICE to suppress notices. |
||
| #2 | 5883 | Stewart Lord | Fixed minor typo in README. | ||
| #1 | 5857 | Stewart Lord | Initial add of track2sql to the public depot. | ||