For each boot_state, report the times spent interleaved with other console output and remove the samples arrays. The time spent to report the times to console is not accounted for. Change-Id: I0c847da98901c56b356b4a933d9ae865dada98b6 Signed-off-by: Kyösti Mälkki <kyosti.malkki@gmail.com> Reviewed-on: https://review.coreboot.org/c/coreboot/+/36584 Tested-by: build bot (Jenkins) <no-reply@coreboot.org> Reviewed-by: Nico Huber <nico.h@gmx.de>
125 lines
2.6 KiB
C
125 lines
2.6 KiB
C
/*
|
|
* This file is part of the coreboot project.
|
|
*
|
|
* This program 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; version 2 of the License.
|
|
*
|
|
* This program 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.
|
|
*
|
|
* blatantly copied from linux/kernel/printk.c
|
|
*/
|
|
|
|
#include <console/cbmem_console.h>
|
|
#include <console/console.h>
|
|
#include <console/streams.h>
|
|
#include <console/vtxprintf.h>
|
|
#include <smp/spinlock.h>
|
|
#include <smp/node.h>
|
|
#include <stddef.h>
|
|
#include <trace.h>
|
|
#include <timer.h>
|
|
|
|
DECLARE_SPIN_LOCK(console_lock)
|
|
|
|
#define TRACK_CONSOLE_TIME (!ENV_SMM && CONFIG(HAVE_MONOTONIC_TIMER))
|
|
|
|
static struct mono_time mt_start, mt_stop;
|
|
static long console_usecs;
|
|
|
|
static void console_time_run(void)
|
|
{
|
|
if (TRACK_CONSOLE_TIME && boot_cpu())
|
|
timer_monotonic_get(&mt_start);
|
|
}
|
|
|
|
static void console_time_stop(void)
|
|
{
|
|
if (TRACK_CONSOLE_TIME && boot_cpu()) {
|
|
timer_monotonic_get(&mt_stop);
|
|
console_usecs += mono_time_diff_microseconds(&mt_start, &mt_stop);
|
|
}
|
|
}
|
|
|
|
void console_time_report(void)
|
|
{
|
|
if (!TRACK_CONSOLE_TIME)
|
|
return;
|
|
|
|
printk(BIOS_DEBUG, "BS: " ENV_STRING " times (exec / console): total (unknown) / %ld ms\n",
|
|
DIV_ROUND_CLOSEST(console_usecs, USECS_PER_MSEC));
|
|
}
|
|
|
|
long console_time_get_and_reset(void)
|
|
{
|
|
if (!TRACK_CONSOLE_TIME)
|
|
return 0;
|
|
|
|
long elapsed = console_usecs;
|
|
console_usecs = 0;
|
|
return elapsed;
|
|
}
|
|
|
|
void do_putchar(unsigned char byte)
|
|
{
|
|
console_time_run();
|
|
console_tx_byte(byte);
|
|
console_time_stop();
|
|
}
|
|
|
|
static void wrap_putchar(unsigned char byte, void *data)
|
|
{
|
|
console_tx_byte(byte);
|
|
}
|
|
|
|
static void wrap_putchar_cbmemc(unsigned char byte, void *data)
|
|
{
|
|
__cbmemc_tx_byte(byte);
|
|
}
|
|
|
|
int do_vprintk(int msg_level, const char *fmt, va_list args)
|
|
{
|
|
int i, log_this;
|
|
|
|
if (CONFIG(SQUELCH_EARLY_SMP) && ENV_ROMSTAGE_OR_BEFORE && !boot_cpu())
|
|
return 0;
|
|
|
|
log_this = console_log_level(msg_level);
|
|
if (log_this < CONSOLE_LOG_FAST)
|
|
return 0;
|
|
|
|
DISABLE_TRACE;
|
|
spin_lock(&console_lock);
|
|
|
|
console_time_run();
|
|
|
|
if (log_this == CONSOLE_LOG_FAST) {
|
|
i = vtxprintf(wrap_putchar_cbmemc, fmt, args, NULL);
|
|
} else {
|
|
i = vtxprintf(wrap_putchar, fmt, args, NULL);
|
|
console_tx_flush();
|
|
}
|
|
|
|
console_time_stop();
|
|
|
|
spin_unlock(&console_lock);
|
|
ENABLE_TRACE;
|
|
|
|
return i;
|
|
}
|
|
|
|
int do_printk(int msg_level, const char *fmt, ...)
|
|
{
|
|
va_list args;
|
|
int i;
|
|
|
|
va_start(args, fmt);
|
|
i = do_vprintk(msg_level, fmt, args);
|
|
va_end(args);
|
|
|
|
return i;
|
|
}
|