#! /var/run/current-system/sw/bin/perl -w use strict; use List::MoreUtils qw(all); use File::Basename; use File::stat; use Nix::Store; use Hydra::Schema; use Hydra::Helper::Nix; use Hydra::Model::DB; use Hydra::Helper::AddBuilds; use Email::Sender::Simple qw(sendmail); use Email::Sender::Transport::SMTP; use Email::Simple; use Email::Simple::Creator; use Sys::Hostname::Long; use Config::General; use Text::Table; use POSIX qw(strftime); use Data::Dump qw(dump); use feature qw/switch/; STDOUT->autoflush(); my $db = Hydra::Model::DB->new(); my $config = getHydraConfig(); sub statusDescription { my ($buildstatus) = @_; my $status = "Failed"; given ($buildstatus) { when (0) { $status = "Success"; } when (1) { $status = "Failed with non-zero exit code"; } when (2) { $status = "Dependency failed"; } when (4) { $status = "Cancelled"; } } return $status; } sub sendEmailNotification { my ($build) = @_; die unless $build->finished; return unless $build->jobset->enableemail && ($build->maintainers ne "" || $build->jobset->emailoverride ne ""); # Do we want to send mail? my $prevBuild; ($prevBuild) = $db->resultset('Builds')->search( { project => $build->project->name , jobset => $build->jobset->name , job => $build->job->name , system => $build->system , finished => 1 , id => { '<', $build->id } , -not => { buildstatus => { -in => [4, 3]} } }, { order_by => ["id DESC"] } ); # If build is cancelled or aborted, do not send email. return if $build->buildstatus == 4 || $build->buildstatus == 3; # If there is a previous (that is not cancelled or aborted) build # with same buildstatus, do not send email. return if defined $prevBuild && ($build->buildstatus == $prevBuild->buildstatus); # Send mail. # !!! should use the Template Toolkit here. print STDERR "sending mail notification to ", $build->maintainers, "\n"; my $jobName = $build->project->name . ":" . $build->jobset->name . ":" . $build->job->name; my $status = statusDescription($build->buildstatus); my $baseurl = hostname_long; my $sender = $config->{'notification_sender'} || (($ENV{'USER'} || "hydra") . "@" . $baseurl); my $selfURI = $config->{'base_uri'} || "http://localhost:3000"; sub showTime { my ($x) = @_; return strftime('%Y-%m-%d %H:%M:%S', localtime($x)); } my $infoTable = Text::Table->new({ align => "left" }, \ " | ", { align => "left" }); my @lines = ( [ "Build ID:", $build->id ], [ "Nix name:", $build->nixname ], [ "Short description:", $build->description || '(not given)' ], [ "Maintainer(s):", $build->maintainers ], [ "System:", $build->system ], [ "Derivation store path:", $build->drvpath ], [ "Output store path:", join(", ", map { $_->path } $build->buildoutputs) ], [ "Time added:", showTime $build->timestamp ], ); push @lines, ( [ "Build started:", showTime $build->starttime ], [ "Build finished:", showTime $build->stoptime ], [ "Duration:", $build->stoptime - $build->starttime . "s" ], ) if $build->starttime; $infoTable->load(@lines); my $inputsTable = Text::Table->new( { title => "Name", align => "left" }, \ " | ", { title => "Type", align => "left" }, \ " | ", { title => "Value", align => "left" }); @lines = (); foreach my $input ($build->inputs) { my $type = $input->type; push @lines, [ $input->name , $input->type , ( $input->type eq "build" || $input->type eq "sysbuild") ? $input->dependency->id : ($input->type eq "string" || $input->type eq "boolean") ? $input->value : ($input->uri . ':' . $input->revision) ]; } $inputsTable->load(@lines); my $loglines = 50; my $logtext = logContents($build->drvpath, $loglines); $logtext = removeAsciiEscapes($logtext); my $body = "Hi,\n" . "\n" . "This is to let you know that Hydra build " . $build->id . " of job " . $jobName . " " . (defined $prevBuild ? "has changed from '" . statusDescription($prevBuild->buildstatus) . "' to '$status'" : "is '$status'" ) .".\n" . "\n" . "Complete build information can be found on this page: " . "$selfURI/build/" . $build->id . "\n" . ($build->buildstatus != 0 ? "\nThe last $loglines lines of the build log are shown at the bottom of this email.\n" : "") . "\n" . "A summary of the build information follows:\n" . "\n" . $infoTable->body . "\n" . "The build inputs were:\n" . "\n" . $inputsTable->title . $inputsTable->rule('-', '+') . $inputsTable->body . "\n" . "Regards,\n\nThe Hydra build daemon.\n" . ($build->buildstatus != 0 ? "\n---\n$logtext" : ""); # stripping trailing spaces from lines $body =~ s/[\ ]+$//gm; my $to = (!$build->jobset->emailoverride eq "") ? $build->jobset->emailoverride : $build->maintainers; my $email = Email::Simple->create( header => [ To => $to, From => "Hydra Build Daemon <$sender>", Subject => "$status: Hydra job $jobName on " . $build->system . ", build " . $build->id, 'X-Hydra-Instance' => $baseurl, 'X-Hydra-Project' => $build->project->name, 'X-Hydra-Jobset' => $build->jobset->name, 'X-Hydra-Job' => $build->job->name, 'X-Hydra-System' => $build->system ], body => "", ); $email->body_set($body); print $email->as_string if $ENV{'HYDRA_MAIL_TEST'}; sendmail($email); } sub addBuildStepOutputs { my ($step) = @_; my $drv = derivationFromPath($step->drvpath); $step->buildstepoutputs->create({ name => $_, path => $drv->{outputs}->{$_} }) foreach keys %{$drv->{outputs}}; } sub nextFreeStepNr { my ($build) = @_; my $max = $build->buildsteps->find( {}, {select => {max => 'stepnr + 1'}, as => ['max']}); return (defined $max && defined $max->get_column('max')) ? $max->get_column('max') : 1; } sub failDependents { my ($drvPath, $errorMsg) = @_; # Get the referrer closure of $drvPath. my @dependentDrvs = computeFSClosure(1, 0, $drvPath); my $time = time(); txn_do($db, sub { my @dependentBuilds = $db->resultset('Builds')->search( { drvpath => [ @dependentDrvs ], finished => 0, busy => 0 }); for my $d (@dependentBuilds) { print STDERR "failing dependent build ", $d->id, " of ", $d->project->name, ":", $d->jobset->name, ":", $d->job->name, "\n"; $d->update( { finished => 1 , logfile => '' , timestamp => time # !!! Why change the timestamp? , iscachedbuild => 0 , buildstatus => $drvPath eq $d->drvpath ? 1 : 2 , starttime => $time , stoptime => $time , errormsg => undef }); my $step = $d->buildsteps->create( { stepnr => nextFreeStepNr($d) , type => 0 # = build , drvpath => $drvPath , busy => 0 , status => 1 , starttime => time , stoptime => time , errormsg => $errorMsg }); addBuildStepOutputs($step); } }); } sub doBuild { my ($build) = @_; my %outputs; $outputs{$_->name} = $_->path foreach $build->buildoutputs->all; my $drvPath = $build->drvpath; my $maxsilent = $build->maxsilent; my $timeout = $build->timeout; my $isCachedBuild = 1; my $outputCreated = 1; # i.e., the Nix build succeeded (but it could be a positive failure) my $startTime = 0; my $stopTime = 0; my $buildStatus = 0; # = succeeded my $errormsg = undef; unless (all { isValidPath($_) } values(%outputs)) { $isCachedBuild = 0; # Do the build. $startTime = time(); my $thisBuildFailed = 0; my $someBuildFailed = 0; # Run Nix to perform the build, and monitor the stderr output # to get notifications about specific build steps, the # associated log files, etc. my $cmd = "nix-store --realise $drvPath " . "--timeout $timeout " . "--max-silent-time $maxsilent --keep-going --fallback " . "--no-build-output --log-type flat --print-build-trace " . "--add-root " . gcRootFor($outputs{out} // $outputs{(sort keys %outputs)[0]}) . " 2>&1"; my $buildStepNr = nextFreeStepNr($build); my %buildSteps; open OUT, "$cmd |" or die; while () { $errormsg .= $_; unless (/^@\s+/) { print STDERR "$_"; next; } if (/^@\s+build-started\s+(\S+)\s+(\S+)\s+(\S+)\s+(\S+)$/) { my $drvPathStep = $1; txn_do($db, sub { my $step = $build->buildsteps->create( { stepnr => ($buildSteps{$drvPathStep} = $buildStepNr++) , type => 0 # = build , drvpath => $drvPathStep , system => $3 , busy => 1 , starttime => time }); addBuildStepOutputs($step); }); } elsif (/^@\s+build-remote\s+(\S+)\s+(\S+)$/) { my $drvPathStep = $1; my $machine = $2; txn_do($db, sub { my $step = $build->buildsteps->find({stepnr => $buildSteps{$drvPathStep}}) or die; $step->update({machine => $machine}); }); } elsif (/^@\s+build-succeeded\s+(\S+)\s+(\S+)$/) { my $drvPathStep = $1; txn_do($db, sub { my $step = $build->buildsteps->find({stepnr => $buildSteps{$drvPathStep}}) or die; $step->update({busy => 0, status => 0, stoptime => time}); }); } elsif (/^@\s+build-failed\s+(\S+)\s+(\S+)\s+(\S+)\s+(.*)$/) { my $drvPathStep = $1; $someBuildFailed = 1; $thisBuildFailed = 1 if $drvPath eq $drvPathStep; my $errorMsg = $4; $errorMsg = "build failed previously (cached)" if $3 eq "cached"; txn_do($db, sub { if ($buildSteps{$drvPathStep}) { my $step = $build->buildsteps->find({stepnr => $buildSteps{$drvPathStep}}) or die; $step->update({busy => 0, status => 1, errormsg => $errorMsg, stoptime => time}); } # Don't write a record if this derivation already # failed previously. This can happen if this is a # restarted build. elsif (scalar $build->buildsteps->search({drvpath => $drvPathStep, type => 0, busy => 0, status => 1}) == 0) { my $step = $build->buildsteps->create( { stepnr => ($buildSteps{$drvPathStep} = $buildStepNr++) , type => 0 # = build , drvpath => $drvPathStep , busy => 0 , status => 1 , starttime => time , stoptime => time , errormsg => $errorMsg }); addBuildStepOutputs($step); } }); # Immediately fail all builds that depend on this derivation. failDependents($drvPathStep, $errorMsg); } elsif (/^@\s+substituter-started\s+(\S+)\s+(\S+)$/) { my $path = $1; txn_do($db, sub { my $step = $build->buildsteps->create( { stepnr => ($buildSteps{$path} = $buildStepNr++) , type => 1 # = substitution , busy => 1 , starttime => time }); # "out" is kinda fake (substitutions don't have named outputs). $step->buildstepoutputs->create({ name => "out", path => $path }); }); } elsif (/^@\s+substituter-succeeded\s+(\S+)$/) { my $path = $1; txn_do($db, sub { my $step = $build->buildsteps->find({stepnr => $buildSteps{$path}}) or die; $step->update({busy => 0, status => 0, stoptime => time}); }); } elsif (/^@\s+substituter-failed\s+(\S+)\s+(\S+)\s+(\S+)$/) { my $path = $1; txn_do($db, sub { my $step = $build->buildsteps->find({stepnr => $buildSteps{$path}}) or die; $step->update({busy => 0, status => 1, errormsg => $3, stoptime => time}); }); } else { print STDERR "unknown Nix trace message: $_"; } } close OUT; my $res = $?; $stopTime = time(); if ($res != 0) { if ($thisBuildFailed && $res == 100 << 8) { $buildStatus = 1; } elsif ($someBuildFailed) { $buildStatus = 2; } else { $buildStatus = 3; } } # Only store the output of running Nix if we have a miscellaneous error. $errormsg = undef unless $buildStatus == 3; } done: txn_do($db, sub { if ($buildStatus == 0) { my $size = 0; my $closureSize = 0; my $releaseName; my @closure = computeFSClosure(0, 0, values %outputs); foreach my $path (@closure) { my ($deriver, $hash, $time, $narSize, $refs) = queryPathInfo($path, 0); $closureSize += $narSize; $size += $narSize if grep { $path eq $_ } values(%outputs); } foreach my $path (values %outputs) { $buildStatus = 6 if $buildStatus == 0 && -f "$path/nix-support/failed"; $releaseName //= getReleaseName($path); } $build->update( { releasename => $releaseName , size => $size , closuresize => $closureSize }); addBuildProducts($db, $build); } $build->update( { finished => 1 , busy => 0 , locker => '' , logfile => '' , timestamp => time # !!! Why change the timestamp? , iscachedbuild => $isCachedBuild , buildstatus => $buildStatus , starttime => $startTime , stoptime => $stopTime , errormsg => $errormsg }); }); sendEmailNotification $build; } my $buildId = $ARGV[0] or die "syntax: $0 BUILD-ID\n"; print STDERR "performing build $buildId\n"; if ($ENV{'HYDRA_MAIL_TEST'}) { sendEmailNotification $db->resultset('Builds')->find($buildId); exit 0; } # Lock the build. If necessary, steal the lock from the parent # process (runner.pl). This is so that if the runner dies, the # children (i.e. the build.pl instances) can continue to run and won't # have the lock taken away. my $build; txn_do($db, sub { $build = $db->resultset('Builds')->find($buildId); die "build $buildId doesn't exist\n" unless defined $build; die "build $buildId already done\n" if $build->finished; if ($build->busy != 0 && $build->locker != getppid) { die "build $buildId is already being built"; } $build->update({busy => 1, locker => $$}); $build->buildsteps->search({busy => 1})->delete_all; $build->buildproducts->delete_all; }); die unless $build; # Do the build. If it throws an error, unlock the build so that it # can be retried. eval { doBuild $build; print "done\n"; }; if ($@) { warn $@; txn_do($db, sub { $build->update({busy => 0, locker => $$}); }); }