2012-02-28 13:14:30 +00:00
|
|
|
BUILDSTATS_BASE = "${TMPDIR}/buildstats/"
|
2011-02-13 00:25:09 +00:00
|
|
|
|
|
|
|
################################################################################
|
2015-05-06 16:19:25 +00:00
|
|
|
# Build statistics gathering.
|
2011-02-13 00:25:09 +00:00
|
|
|
#
|
|
|
|
# The CPU and Time gathering/tracking functions and bbevent inspiration
|
2015-05-06 16:19:25 +00:00
|
|
|
# were written by Christopher Larson and can be seen here:
|
2011-02-13 00:25:09 +00:00
|
|
|
# http://kergoth.pastey.net/142813
|
2015-05-06 16:19:25 +00:00
|
|
|
#
|
2011-02-13 00:25:09 +00:00
|
|
|
################################################################################
|
|
|
|
|
|
|
|
def get_process_cputime(pid):
|
2013-05-07 12:55:58 +00:00
|
|
|
with open("/proc/%d/stat" % pid, "r") as f:
|
|
|
|
fields = f.readline().rstrip().split()
|
2011-02-13 00:25:09 +00:00
|
|
|
# 13: utime, 14: stime, 15: cutime, 16: cstime
|
|
|
|
return sum(int(field) for field in fields[13:16])
|
|
|
|
|
|
|
|
def get_cputime():
|
2013-05-07 12:55:58 +00:00
|
|
|
with open("/proc/stat", "r") as f:
|
|
|
|
fields = f.readline().rstrip().split()[1:]
|
2011-02-13 00:25:09 +00:00
|
|
|
return sum(int(field) for field in fields)
|
|
|
|
|
2015-12-17 14:54:08 +00:00
|
|
|
def set_timedata(var, d, server_time=None):
|
2011-02-13 00:25:09 +00:00
|
|
|
import time
|
2014-03-17 15:04:10 +00:00
|
|
|
if server_time:
|
|
|
|
time = server_time
|
|
|
|
else:
|
|
|
|
time = time.time()
|
2011-02-13 00:25:09 +00:00
|
|
|
cputime = get_cputime()
|
|
|
|
proctime = get_process_cputime(os.getpid())
|
2015-12-17 14:54:08 +00:00
|
|
|
d.setVar(var, (time, cputime, proctime))
|
2011-02-13 00:25:09 +00:00
|
|
|
|
2015-12-17 14:54:08 +00:00
|
|
|
def get_timedata(var, d, server_time=None):
|
2011-02-13 00:25:09 +00:00
|
|
|
import time
|
2015-12-17 14:54:08 +00:00
|
|
|
timedata = d.getVar(var, False)
|
2011-02-13 00:25:09 +00:00
|
|
|
if timedata is None:
|
|
|
|
return
|
|
|
|
oldtime, oldcpu, oldproc = timedata
|
|
|
|
procdiff = get_process_cputime(os.getpid()) - oldproc
|
|
|
|
cpudiff = get_cputime() - oldcpu
|
2014-03-17 15:04:10 +00:00
|
|
|
if server_time:
|
|
|
|
end_time = server_time
|
|
|
|
else:
|
|
|
|
end_time = time.time()
|
|
|
|
timediff = end_time - oldtime
|
2011-02-13 00:25:09 +00:00
|
|
|
if cpudiff > 0:
|
|
|
|
cpuperc = float(procdiff) * 100 / cpudiff
|
|
|
|
else:
|
|
|
|
cpuperc = None
|
|
|
|
return timediff, cpuperc
|
2015-05-06 16:19:25 +00:00
|
|
|
|
2015-12-17 14:54:08 +00:00
|
|
|
def write_task_data(status, logfile, e, d):
|
|
|
|
bn = d.getVar('BUILDNAME', True)
|
|
|
|
bsdir = os.path.join(d.getVar('BUILDSTATS_BASE', True), bn)
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(os.path.join(logfile), "a") as f:
|
2015-12-17 14:54:08 +00:00
|
|
|
timedata = get_timedata("__timedata_task", d, e.time)
|
2015-05-06 16:19:27 +00:00
|
|
|
if timedata:
|
|
|
|
elapsedtime, cpu = timedata
|
2015-12-17 14:54:08 +00:00
|
|
|
f.write(d.expand("${PF}: %s: Elapsed time: %0.2f seconds \n" %
|
|
|
|
(e.task, elapsedtime)))
|
2015-05-06 16:19:27 +00:00
|
|
|
if cpu:
|
|
|
|
f.write("CPU usage: %0.1f%% \n" % cpu)
|
|
|
|
if status is "passed":
|
|
|
|
f.write("Status: PASSED \n")
|
|
|
|
else:
|
|
|
|
f.write("Status: FAILED \n")
|
|
|
|
f.write("Ended: %0.2f \n" % e.time)
|
2011-02-13 00:25:09 +00:00
|
|
|
|
|
|
|
python run_buildstats () {
|
|
|
|
import bb.build
|
|
|
|
import bb.event
|
2011-02-16 02:37:59 +00:00
|
|
|
import time, subprocess, platform
|
2011-02-13 00:25:09 +00:00
|
|
|
|
2015-12-17 14:54:08 +00:00
|
|
|
bn = d.getVar('BUILDNAME', True)
|
|
|
|
bsdir = os.path.join(d.getVar('BUILDSTATS_BASE', True), bn)
|
|
|
|
taskdir = os.path.join(bsdir, d.getVar('PF', True))
|
2015-12-17 14:54:01 +00:00
|
|
|
|
2011-02-13 00:25:09 +00:00
|
|
|
if isinstance(e, bb.event.BuildStarted):
|
2011-08-03 19:31:08 +00:00
|
|
|
########################################################################
|
2011-02-13 00:25:09 +00:00
|
|
|
# at first pass make the buildstats heriarchy and then
|
|
|
|
# set the buildname
|
2011-08-03 19:31:08 +00:00
|
|
|
########################################################################
|
2015-05-06 16:19:26 +00:00
|
|
|
bb.utils.mkdirhier(bsdir)
|
2015-12-17 14:54:08 +00:00
|
|
|
set_timedata("__timedata_build", d)
|
2011-02-13 00:25:09 +00:00
|
|
|
build_time = os.path.join(bsdir, "build_stats")
|
|
|
|
# write start of build into build_time
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(build_time, "a") as f:
|
|
|
|
host_info = platform.uname()
|
|
|
|
f.write("Host Info: ")
|
|
|
|
for x in host_info:
|
|
|
|
if x:
|
|
|
|
f.write(x + " ")
|
|
|
|
f.write("\n")
|
|
|
|
f.write("Build Started: %0.2f \n" % time.time())
|
2015-05-06 16:19:25 +00:00
|
|
|
|
2011-02-13 00:25:09 +00:00
|
|
|
elif isinstance(e, bb.event.BuildCompleted):
|
|
|
|
build_time = os.path.join(bsdir, "build_stats")
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(build_time, "a") as f:
|
|
|
|
########################################################################
|
|
|
|
# Write build statistics for the build
|
|
|
|
########################################################################
|
2015-12-17 14:54:08 +00:00
|
|
|
timedata = get_timedata("__timedata_build", d)
|
2015-05-06 16:19:27 +00:00
|
|
|
if timedata:
|
|
|
|
time, cpu = timedata
|
|
|
|
# write end of build and cpu used into build_time
|
|
|
|
f.write("Elapsed time: %0.2f seconds \n" % (time))
|
|
|
|
if cpu:
|
|
|
|
f.write("CPU usage: %0.1f%% \n" % cpu)
|
2011-02-13 00:25:09 +00:00
|
|
|
|
|
|
|
if isinstance(e, bb.build.TaskStarted):
|
2015-12-17 14:54:08 +00:00
|
|
|
set_timedata("__timedata_task", d, e.time)
|
2015-05-06 16:19:26 +00:00
|
|
|
bb.utils.mkdirhier(taskdir)
|
2011-02-13 00:25:09 +00:00
|
|
|
# write into the task event file the name and start time
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(os.path.join(taskdir, e.task), "a") as f:
|
|
|
|
f.write("Event: %s \n" % bb.event.getName(e))
|
|
|
|
f.write("Started: %0.2f \n" % e.time)
|
2011-02-13 00:25:09 +00:00
|
|
|
|
|
|
|
elif isinstance(e, bb.build.TaskSucceeded):
|
2015-12-17 14:54:08 +00:00
|
|
|
write_task_data("passed", os.path.join(taskdir, e.task), e, d)
|
2011-02-13 00:25:09 +00:00
|
|
|
if e.task == "do_rootfs":
|
2015-05-06 16:19:25 +00:00
|
|
|
bs = os.path.join(bsdir, "build_stats")
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(bs, "a") as f:
|
2015-12-17 14:54:08 +00:00
|
|
|
rootfs = d.getVar('IMAGE_ROOTFS', True)
|
2015-05-06 16:19:27 +00:00
|
|
|
rootfs_size = subprocess.Popen(["du", "-sh", rootfs], stdout=subprocess.PIPE).stdout.read()
|
|
|
|
f.write("Uncompressed Rootfs size: %s" % rootfs_size)
|
2011-02-13 00:25:09 +00:00
|
|
|
|
|
|
|
elif isinstance(e, bb.build.TaskFailed):
|
2015-12-17 14:54:08 +00:00
|
|
|
write_task_data("failed", os.path.join(taskdir, e.task), e, d)
|
2011-08-03 19:31:08 +00:00
|
|
|
########################################################################
|
2015-05-06 16:19:25 +00:00
|
|
|
# Lets make things easier and tell people where the build failed in
|
|
|
|
# build_status. We do this here because BuildCompleted triggers no
|
2011-08-03 19:31:08 +00:00
|
|
|
# matter what the status of the build actually is
|
|
|
|
########################################################################
|
2011-02-13 00:25:09 +00:00
|
|
|
build_status = os.path.join(bsdir, "build_stats")
|
2015-05-06 16:19:27 +00:00
|
|
|
with open(build_status, "a") as f:
|
2015-12-17 14:54:08 +00:00
|
|
|
f.write(d.expand("Failed at: ${PF} at task: %s \n" % e.task))
|
2011-02-13 00:25:09 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
addhandler run_buildstats
|
2013-06-12 16:31:57 +00:00
|
|
|
run_buildstats[eventmask] = "bb.event.BuildStarted bb.event.BuildCompleted bb.build.TaskStarted bb.build.TaskSucceeded bb.build.TaskFailed"
|
2011-02-13 00:25:09 +00:00
|
|
|
|