#!/usr/bin/perl
# Housekeeping program, started by cron, loncontrol and loncron.pl
#
# $Id: loncron,v 1.95 2011/11/14 17:27:34 raeburn Exp $
#
# Copyright Michigan State University Board of Trustees
#
# This file is part of the LearningOnline Network with CAPA (LON-CAPA).
#
# LON-CAPA is free software; you can redistribute it and/or modify
# it under the terms of the GNU General Public License as published by
# the Free Software Foundation; either version 2 of the License, or
# (at your option) any later version.
#
# LON-CAPA is distributed in the hope that it will be useful,
# but WITHOUT ANY WARRANTY; without even the implied warranty of
# MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
# GNU General Public License for more details.
#
# You should have received a copy of the GNU General Public License
# along with LON-CAPA; if not, write to the Free Software
# Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
#
# /home/httpd/html/adm/gpl.txt
#
# http://www.lon-capa.org/
#
$|=1;
use strict;
use lib '/home/httpd/lib/perl/';
use LONCAPA::Configuration;
use LONCAPA;
use Apache::lonnet;
use Apache::loncommon;
use IO::File;
use IO::Socket;
use HTML::Entities;
use Getopt::Long;
#globals
use vars qw (%perlvar %simplestatus $errors $warnings $notices $totalcount);
my $statusdir="/home/httpd/html/lon-status";
# --------------------------------------------------------- Output error status
sub log {
my $fh=shift;
if ($fh) { print $fh @_ }
}
sub errout {
my $fh=shift;
&log($fh,(<
Notices | $notices |
Warnings | $warnings |
Errors | $errors |
Top
ENDERROUT
}
sub rotate_logfile {
my ($file,$fh,$description) = @_;
my $size=(stat($file))[7];
if ($size>40000) {
&log($fh,"Rotating $description ...
");
rename("$file.2","$file.3");
rename("$file.1","$file.2");
rename("$file","$file.1");
}
}
sub start_daemon {
my ($fh,$daemon,$pidfile,$args) = @_;
my $progname=$daemon;
if ($daemon eq 'lonc') {
$progname='loncnew';
}
my $error_fname="$perlvar{'lonDaemons'}/logs/${daemon}_errors";
&rotate_logfile($error_fname,$fh,'error logs');
if ($daemon eq 'lonc') {
&clean_sockets($fh);
}
system("$perlvar{'lonDaemons'}/$progname 2>$perlvar{'lonDaemons'}/logs/${daemon}_errors");
sleep 1;
if (-e $pidfile) {
&log($fh,"Seems like it started ...
");
my $lfh=IO::File->new("$pidfile");
my $daemonpid=<$lfh>;
chomp($daemonpid);
if ($daemonpid =~ /^\d+$/ && kill 0 => $daemonpid) {
return 1;
} else {
return 0;
}
}
&log($fh,"Seems like that did not work!
");
$errors++;
return 0;
}
sub checkon_daemon {
my ($fh,$daemon,$maxsize,$send,$args)=@_;
my $result;
&log($fh,'
'.$daemon.'
Log
');
printf("%-15s ",$daemon);
if (-e "$perlvar{'lonDaemons'}/logs/$daemon.log"){
open (DFH,"tail -n25 $perlvar{'lonDaemons'}/logs/$daemon.log|");
while (my $line=) {
&log($fh,"$line");
if ($line=~/INFO/) { $notices++; }
if ($line=~/WARNING/) { $notices++; }
if ($line=~/CRITICAL/) { $warnings++; }
};
close (DFH);
}
&log($fh,"
");
my $pidfile="$perlvar{'lonDaemons'}/logs/$daemon.pid";
my $restartflag=1;
my $daemonpid;
if (-e $pidfile) {
my $lfh=IO::File->new("$pidfile");
$daemonpid=<$lfh>;
chomp($daemonpid);
if ($daemonpid =~ /^\d+$/ && kill 0 => $daemonpid) {
&log($fh,"$daemon at pid $daemonpid responding");
if ($send) { &log($fh,", sending $send"); }
&log($fh,"
");
if ($send eq 'USR1') { kill USR1 => $daemonpid; }
if ($send eq 'USR2') { kill USR2 => $daemonpid; }
$restartflag=0;
if ($send eq 'USR2') {
$result = 'reloaded';
print "reloaded\n";
} else {
$result = 'running';
print "running\n";
}
} else {
$errors++;
&log($fh,"$daemon at pid $daemonpid not responding
");
$restartflag=1;
&log($fh,"Decided to clean up stale .pid file and restart $daemon
");
}
}
if ($restartflag==1) {
$simplestatus{$daemon}='off';
$errors++;
my $kadaemon=$daemon;
if ($kadaemon eq 'lonmemcached') { $kadaemon='memcached'; }
&log($fh,'
Killall '.$daemon.': '.
`killall $kadaemon 2>&1`.' - ');
sleep 1;
&log($fh,unlink($pidfile).' - '.
`killall -9 $kadaemon 2>&1`.
'
');
&log($fh,"$daemon not running, trying to start
");
if (&start_daemon($fh,$daemon,$pidfile,$args)) {
&log($fh,"$daemon at pid $daemonpid responding
");
$simplestatus{$daemon}='restarted';
$result = 'started';
print "started\n";
} else {
$errors++;
&log($fh,"$daemon at pid $daemonpid not responding
");
&log($fh,"Give it one more try ...
");
print " ";
if (&start_daemon($fh,$daemon,$pidfile,$args)) {
&log($fh,"$daemon at pid $daemonpid responding
");
$simplestatus{$daemon}='restarted';
$result = 'started';
print "started\n";
} else {
$result = 'failed';
print " failed\n";
$simplestatus{$daemon}='failed';
$errors++; $errors++;
&log($fh,"$daemon at pid $daemonpid not responding
");
&log($fh,"Unable to start $daemon
");
}
}
if (-e "$perlvar{'lonDaemons'}/logs/$daemon.log"){
&log($fh,"");
open (DFH,"tail -n100 $perlvar{'lonDaemons'}/logs/$daemon.log|");
while (my $line=) {
&log($fh,"$line");
if ($line=~/WARNING/) { $notices++; }
if ($line=~/CRITICAL/) { $notices++; }
};
close (DFH);
&log($fh,"
");
}
}
my $fname="$perlvar{'lonDaemons'}/logs/$daemon.log";
&rotate_logfile($fname,$fh,'logs');
&errout($fh);
return $result;
}
# --------------------------------------------------------------------- Machine
sub log_machine_info {
my ($fh)=@_;
&log($fh,'
Machine Information
');
&log($fh,"loadavg
");
open (LOADAVGH,"/proc/loadavg");
my $loadavg=;
close (LOADAVGH);
&log($fh,"$loadavg");
my @parts=split(/\s+/,$loadavg);
if ($parts[1]>4.0) {
$errors++;
} elsif ($parts[1]>2.0) {
$warnings++;
} elsif ($parts[1]>1.0) {
$notices++;
}
&log($fh,"df
");
&log($fh,"");
open (DFH,"df|");
while (my $line=) {
&log($fh,&encode_entities($line,'<>&"'));
@parts=split(/\s+/,$line);
my $usage=$parts[4];
$usage=~s/\W//g;
if ($usage>90) {
$warnings++;
$notices++;
} elsif ($usage>80) {
$warnings++;
} elsif ($usage>60) {
$notices++;
}
if ($usage>95) { $warnings++; $warnings++; $simplestatus{'diskfull'}++; }
}
close (DFH);
&log($fh,"
");
&log($fh,"ps
");
&log($fh,"");
my $psproc=0;
open (PSH,"ps aux --cols 140 |");
while (my $line=) {
&log($fh,&encode_entities($line,'<>&"'));
$psproc++;
}
close (PSH);
&log($fh,"
");
if ($psproc>200) { $notices++; }
if ($psproc>250) { $notices++; }
&log($fh,"distprobe
");
&log($fh,"");
open(DSH,"$perlvar{'lonDaemons'}/distprobe |");
while (my $line=) {
&log($fh,&encode_entities($line,'<>&"'));
$psproc++;
}
close(DSH);
&log($fh,"
");
&errout($fh);
}
sub start_logging {
my $fh=IO::File->new(">$statusdir/newstatus.html");
my %simplestatus=();
my $now=time;
my $date=localtime($now);
&log($fh,(<
LON Status Report $perlvar{'lonHostID'}
LON Status Report $perlvar{'lonHostID'}
$date ($now)
- Configuration
- Machine Information
- Temporary Files
- Session Tokens
- httpd
- lonsql
- lond
- lonc
- lonnet
- Connections
- Delayed Messages
- Error Count
Configuration
PerlVars
ENDHEADERS
foreach my $varname (sort(keys(%perlvar))) {
&log($fh,"$varname | ".
&encode_entities($perlvar{$varname},'<>&"')." |
\n");
}
&log($fh,"
Hosts
");
my %hostname = &Apache::lonnet::all_hostnames();
foreach my $id (sort(keys(%hostname))) {
my $role = (&Apache::lonnet::is_library($id) ? 'library'
: 'access');
&log($fh,
"$id | ".&Apache::lonnet::host_domain($id).
" | ".$role.
" | ".&Apache::lonnet::hostname($id)." |
\n");
}
&log($fh,"
Spare Hosts
");
foreach my $type (sort(keys(%Apache::lonnet::spareid))) {
&log($fh,"- $type\n
");
foreach my $id (@{ $Apache::lonnet::spareid{$type} }) {
&log($fh,"- $id
\n");
}
&log($fh,"
\n \n");
}
&log($fh,"
\n");
return $fh;
}
# --------------------------------------------------------------- clean out tmp
sub clean_tmp {
my ($fh)=@_;
&log($fh,'
Temporary Files
');
my ($cleaned,$old,$removed) = (0,0,0);
my %errors = (
dir => [],
file => [],
failopen => [],
);
my %error_titles = (
dir => 'failed to remove empty directory:',
file => 'failed to unlike stale file',
failopen => 'failed to open file or directory'
);
($cleaned,$old,$removed) = &recursive_clean_tmp('',$cleaned,$old,$removed,\%errors);
&log($fh,"Cleaned up: ".$cleaned." files; removed: $removed empty directories; (found: $old old checkout tokens)");
foreach my $key (sort(keys(%errors))) {
if (ref($errors{$key}) eq 'ARRAY') {
if (@{$errors{$key}} > 0) {
&log($fh,"Error during cleanup ($error_titles{$key}):- ".
join('
- ',@{$errors{$key}}).'
');
}
}
}
}
sub recursive_clean_tmp {
my ($subdir,$cleaned,$old,$removed,$errors) = @_;
my $base = "$perlvar{'lonDaemons'}/tmp";
my $path = $base;
next if ($subdir =~ m{\.\./});
next unless (ref($errors) eq 'HASH');
unless ($subdir eq '') {
$path .= '/'.$subdir;
}
if (opendir(my $dh,"$path")) {
while (my $file = readdir($dh)) {
next if ($file =~ /^\.\.?$/);
my $fname = "$path/$file";
if (-d $fname) {
my $innerdir;
if ($subdir eq '') {
$innerdir = $file;
} else {
$innerdir = $subdir.'/'.$file;
}
($cleaned,$old,$removed) =
&recursive_clean_tmp($innerdir,$cleaned,$old,$removed,$errors);
my @doms = &Apache::lonnet::current_machine_domains();
if (open(my $dirhandle,$fname)) {
unless (($innerdir eq 'helprequests') ||
(($innerdir =~ /^addcourse/) && ($innerdir !~ m{/\d+$}))) {
my @contents = grep {!/^\.\.?$/} readdir($dirhandle);
join('&&',@contents)."\n";
if (scalar(grep {!/^\.\.?$/} readdir($dirhandle)) == 0) {
closedir($dirhandle);
if ($fname =~ m{^\Q$perlvar{'lonDaemons'}\E/tmp/}) {
if (rmdir($fname)) {
$removed ++;
} elsif (ref($errors->{dir}) eq 'ARRAY') {
push(@{$errors->{dir}},$fname);
}
}
}
} else {
closedir($dirhandle);
}
}
} else {
my ($dev,$ino,$mode,$nlink,
$uid,$gid,$rdev,$size,
$atime,$mtime,$ctime,
$blksize,$blocks)=stat($fname);
my $now=time;
my $since=$now-$mtime;
if ($since>$perlvar{'lonExpire'}) {
if ($subdir eq '') {
my $line='';
if ($fname =~ /\.db$/) {
if (unlink($fname)) {
$cleaned++;
} elsif (ref($errors->{file}) eq 'ARRAY') {
push(@{$errors->{file}},$fname);
}
} elsif (open(PROBE,$fname)) {
my $line='';
$line=;
close(PROBE);
if ($line=~/^CHECKOUTTOKEN\&/) {
if ($since>365*$perlvar{'lonExpire'}) {
if (unlink($fname)) {
$cleaned++;
} elsif (ref($errors->{file}) eq 'ARRAY') {
push(@{$errors->{file}},$fname);
}
} else {
$old++;
}
} else {
if (unlink($fname)) {
$cleaned++;
} elsif (ref($errors->{file}) eq 'ARRAY') {
push(@{$errors->{file}},$fname);
}
}
} elsif (ref($errors->{failopen}) eq 'ARRAY') {
push(@{$errors->{failopen}},$fname);
}
} else {
if (unlink($fname)) {
$cleaned++;
} elsif (ref($errors->{file}) eq 'ARRAY') {
push(@{$errors->{file}},$fname);
}
}
}
}
}
closedir($dh);
} elsif (ref($errors->{failopen}) eq 'ARRAY') {
push(@{$errors->{failopen}},$path);
}
return ($cleaned,$old,$removed);
}
# ------------------------------------------------------------ clean out lonIDs
sub clean_lonIDs {
my ($fh)=@_;
&log($fh,'
Session Tokens
');
my $cleaned=0;
my $active=0;
while (my $fname=<$perlvar{'lonIDsDir'}/*>) {
my ($dev,$ino,$mode,$nlink,
$uid,$gid,$rdev,$size,
$atime,$mtime,$ctime,
$blksize,$blocks)=stat($fname);
my $now=time;
my $since=$now-$mtime;
if ($since>$perlvar{'lonExpire'}) {
$cleaned++;
&log($fh,"Unlinking $fname
");
unlink("$fname");
} else {
$active++;
}
}
&log($fh,"Cleaned up ".$cleaned." stale session token(s).
");
&log($fh,"$active open session(s)
");
}
# ----------------------------------------------------------- clean out sockets
sub clean_sockets {
my ($fh)=@_;
my $cleaned=0;
opendir(SOCKETS,$perlvar{'lonSockDir'});
while (my $fname=readdir(SOCKETS)) {
next if (-d $fname
|| $fname=~/(mysqlsock|maximasock|rsock|\Q$perlvar{'lonSockDir'}\E)/);
$cleaned++;
&log($fh,"Unlinking $fname
");
unlink("/home/httpd/sockets/$fname");
}
&log($fh,"Cleaned up ".$cleaned." stale sockets.
");
}
# ----------------------------------------------------------------------- httpd
sub check_httpd_logs {
my ($fh)=@_;
if (open(PIPE,"./lchttpdlogs|")) {
while (my $line=) {
&log($fh,$line);
if ($line=~/\[error\]/) { $notices++; }
}
close(PIPE);
}
&errout($fh);
}
# ---------------------------------------------------------------------- lonnet
sub rotate_lonnet_logs {
my ($fh)=@_;
&log($fh,'
lonnet
Temp Log
');
print "checking logs\n";
if (-e "$perlvar{'lonDaemons'}/logs/lonnet.log"){
open (DFH,"tail -n50 $perlvar{'lonDaemons'}/logs/lonnet.log|");
while (my $line=) {
&log($fh,&encode_entities($line,'<>&"'));
}
close (DFH);
}
&log($fh,"
Perm Log
");
if (-e "$perlvar{'lonDaemons'}/logs/lonnet.perm.log") {
open(DFH,"tail -n10 $perlvar{'lonDaemons'}/logs/lonnet.perm.log|");
while (my $line=) {
&log($fh,&encode_entities($line,'<>&"'));
}
close (DFH);
} else { &log($fh,"No perm log\n") }
my $fname="$perlvar{'lonDaemons'}/logs/lonnet.log";
&rotate_logfile($fname,$fh,'lonnet log');
&log($fh,"
");
&errout($fh);
}
sub rotate_other_logs {
my ($fh) = @_;
my %logs = (
autoenroll => 'Auto Enroll log',
autocreate => 'Create Course log',
searchcat => 'Search Cataloguing log',
autoupdate => 'Auto Update log',
refreshcourseids_db => 'Refresh CourseIDs db log',
);
foreach my $item (keys(%logs)) {
my $fname=$perlvar{'lonDaemons'}.'/logs/'.$item.'.log';
&rotate_logfile($fname,$fh,$logs{$item});
}
}
# ----------------------------------------------------------------- Connections
sub test_connections {
my ($fh)=@_;
&log($fh,'
Connections
');
print "testing connections\n";
&log($fh,"");
my ($good,$bad)=(0,0);
my %hostname = &Apache::lonnet::all_hostnames();
foreach my $tryserver (sort(keys(%hostname))) {
print(".");
my $result;
my $answer=&Apache::lonnet::reply("ping",$tryserver);
if ($answer eq "$tryserver:$perlvar{'lonHostID'}") {
$result="ok";
$good++;
} else {
$result=$answer;
$warnings++;
if ($answer eq 'con_lost') {
$bad++;
$warnings++;
} else {
$good++; #self connection
}
}
if ($answer =~ /con_lost/) { print(" $tryserver down\n"); }
&log($fh,"$tryserver | $result |
\n");
}
&log($fh,"
");
print "\n$good good, $bad bad connections\n";
&errout($fh);
}
# ------------------------------------------------------------ Delayed messages
sub check_delayed_msg {
my ($fh)=@_;
&log($fh,'
Delayed Messages
');
print "checking buffers\n";
&log($fh,'Scanning Permanent Log
');
my $unsend=0;
my $dfh=IO::File->new("$perlvar{'lonDaemons'}/logs/lonnet.perm.log");
while (my $line=<$dfh>) {
my ($time,$sdf,$dserv,$dcmd)=split(/:/,$line);
if ($sdf eq 'F') {
my $local=localtime($time);
&log($fh,"Failed: $time, $dserv, $dcmd
");
$warnings++;
}
if ($sdf eq 'S') { $unsend--; }
if ($sdf eq 'D') { $unsend++; }
}
&log($fh,"Total unsend messages: $unsend
\n");
if ($unsend > 0) {
$warnings=$warnings+5*$unsend;
}
if ($unsend) { $simplestatus{'unsend'}=$unsend; }
&log($fh,"Outgoing Buffer
\n");
# list directory with delayed messages and remember offline servers
my %servers=();
open (DFH,"ls -lF $perlvar{'lonSockDir'}/delayed|");
while (my $line=) {
my ($server)=($line=~/\.(\w+)$/);
if ($server) { $servers{$server}=1; }
&log($fh,&encode_entities($line,'<>&"'));
}
&log($fh,"
\n");
close (DFH);
my %hostname = &Apache::lonnet::all_hostnames();
my $numhosts = scalar(keys(%hostname));
# pong to all servers that have delayed messages
# this will trigger a reverse connection, which should flush the buffers
foreach my $tryserver (sort(keys(%servers))) {
if ($hostname{$tryserver} || !$numhosts) {
my $answer;
eval {
local $SIG{ ALRM } = sub { die "TIMEOUT" };
alarm(20);
$answer = &Apache::lonnet::reply("pong",$tryserver);
alarm(0);
};
if ($@ && $@ =~ m/TIMEOUT/) {
&log($fh,"Attempted pong to $tryserver timed out
");
print "time out while contacting: $tryserver for pong\n";
} else {
&log($fh,"Pong to $tryserver: $answer
");
}
} else {
&log($fh,"$tryserver has delayed messages, but is not part of the cluster -- skipping 'Pong'.
");
}
}
}
sub finish_logging {
my ($fh)=@_;
&log($fh,"\n");
$totalcount=$notices+4*$warnings+100*$errors;
&errout($fh);
&log($fh,"Total Error Count: $totalcount
");
my $now=time;
my $date=localtime($now);
&log($fh,"
$date ($now)