• Status: Solved
  • Priority: Medium
  • Security: Public
  • Views: 896
  • Last Modified:

How can I diagnose my log file to work out why my server load was 9.6?

My Apache web server died so I ran the following command

killall -9 sys-snap.sh

And then restarted httpd. My log file is here:

http://dl.dropbox.com/u/12337149/30.log

I can't make much sense of it I still don't understand why the server died
0
wordswithfriends
Asked:
wordswithfriends
1 Solution
 
Joseph GanSystem AdminCommented:
I've noticed the mysql daemon was running over 876 hours, is this normal for your server?

mysql    22229  3.0  2.3 164164 18496 ?        Sl   Jan31 876:49  \_ /usr/libexec/mysqld
0
 
wordswithfriendsAuthor Commented:
It doesn't sound normal although I only have a very passing knowledge of how the daemon is supposed to work.  Let's say the user opens a web page that runs a SELECT query that takes a few seconds.  In this case would the server open and quickly close a MySQL demon?  If this is true, then 876 hours would be very unusual

On the other hand if there is a single mysql that sits in the background and processes all queries then maybe it's possible.  Running

ps -aux | grep mysql

I get

[root@wor system-snapshot]# ps -aux | grep mysql
Warning: bad syntax, perhaps a bogus '-'? See /usr/share/doc/procps-3.2.7/FAQ
root     22151  0.0  0.1  11932  1416 ?        S    Jan31   0:00 /bin/sh /usr/bin/mysqld_safe --datadir=/var/lib/mysql --socket=/var/lib/mysql/mysql.sock --log-error=/var/log/mysqld.log --pid-file=/var/run/mysqld/mysqld.pid --user=mysql
mysql    22229  3.1  2.3 164164 18560 ?        Sl   Jan31 922:49 /usr/libexec/mysqld --basedir=/usr --datadir=/var/lib/mysql --user=mysql --pid-file=/var/run/mysqld/mysqld.pid --skip-external-locking --socket=/var/lib/mysql/mysql.sock

It looks like it is still going.  What is normal behavior?
0
 
t-maxCommented:
Usually it's normal to have the MySQL daemon running for that long (or even much more) if you have a running DB on the server.
Apparently there's nothing wrong in the log you posted. You had free memory, the sum of %CPU in all the processes is below 10-15% cpu power. What is missing is disk space info, so you might want to check /tmp or /var free space.
0
What does it mean to be "Always On"?

Is your cloud always on? With an Always On cloud you won't have to worry about downtime for maintenance or software application code updates, ensuring that your bottom line isn't affected.

 
wordswithfriendsAuthor Commented:
heaps of disk space

 df -h
Filesystem            Size  Used Avail Use% Mounted on
/dev/vzfs              30G  1.8G   29G   6% /
0
 
arnoldCommented:
How long has the system been up? (uptime)

There are not enough hours from Jan 31 to today to account for the 960hours reflected.  
Look at the /var/log/httpd/error_log to see if there is a clue to why it crashed. Check if you have a core dump in the web directory
find /path/to/web -name 'core'

If you have, you could analyze the core dump in an attempt to determine the cause of apach's crash.

You could setup a cron to collect data iostat/vmstat/memstat/etc. this way should apache crash again, you will have a trend of data leading up to it.
Depending on what you have i.e. php, etc., you may not have allocated enough resources.

The apache log should have a clue as to why it crashed.
0
 
wordswithfriendsAuthor Commented:
uptime
 23:07:55 up 21 days,  5:21,  2 users,  load average: 0.82, 0.35, 0.23

SIGTERM was me restarting Apache.  Doesn't seem like anything interesting before then.


[Sun Feb 20 06:06:46 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:07:55 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:09:04 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:10:14 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:11:41 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:12:50 2011] [client 127.0.0.1] File does not exist: /var/www/html/whm-server-status
[Sun Feb 20 06:21:55 2011] [notice] caught SIGTERM, shutting down

find /var/www -name 'core' doesn't return any results.

Could you give more details about the cron job?
0
 
arnoldCommented:
You can setup a cron job for a script that runs vmstat 5 5, iostat 5 5
top -n 1
etc.

If you have another linux/unix box on which you can setup cacti or set it up on this one and by enabling snmp on the web/mysql/mail/courier,etc. system you can have cacti collect the data as well which will then be represented in graphical term CPU, memory, HD, and there are application templates for apache.
Should it get stuck in the same way, use strace -f -p <pid_of_apache_parent> to see what it is doing.
You may have allocated too few children or your system was experiencing a DoS attack.
Check the access_log to see the number of queries it was getting per second i.e. was there a spike in the number of requests per second it was recording in the log.
The time stamp is in unix time format (epoch number of elapsed seconds since 1/1/1970)

another option is to tabulate how many requests were being seen from the same source.
0
 
wordswithfriendsAuthor Commented:
This was too complicated for me to follow
0
 
arnoldCommented:
To determine the underlying cause, you need to collect data such that when the issue reoccurs, you can look at the collected data to see whether there is something there that can explain the situation.
0
 
wordswithfriendsAuthor Commented:
Understood.  But the following instructions

You can setup a cron job for a script that runs vmstat 5 5, iostat 5 5

Whilst may becorrect is not particularly easy to follow
0
 
arnoldCommented:
Do you know how to setup a cron job?

Create a script: datacollection.sh
Add it into the cron job
*/5 * * * * /path/to/script/datacollection.sh iostat
*/5 * * * * /path/to/script/datacollection.sh vmstat

The script will add entries into the iostat.txt or vmstat.txt with the start date/time and end  date/time
Similarly you could add additional parameters into the script for collection purposes i.e. top -n 1 to get the currently top active process list. ps -ef to get a complete list of all processes on the system. etc.
#!/bin/sh

if  [ ! -z "$1"  ] ; then 
    if [  "$1" = 'vmstat' -o "$1" = 'iostat'  ]  ; then
(echo start `date +"%Y%m%e%H%M%S"`;
$1 5 5; 
echo end `date +"%Y%m%e%H%M%S"`) >> /some/location/$1.txt
fi
else
echo "Usage : $0 (vmstat|iostat)"
exit 1;
fi

Open in new window

0

Featured Post

VIDEO: THE CONCERTO CLOUD FOR HEALTHCARE

Modern healthcare requires a modern cloud. View this brief video to understand how the Concerto Cloud for Healthcare can help your organization.

Tackle projects and never again get stuck behind a technical roadblock.
Join Now