Igt-dev Archive on lore.kernel.org
 help / color / mirror / Atom feed
From: Daniel Vetter <daniel@ffwll.ch>
To: Petri Latvala <petri.latvala@intel.com>
Cc: igt-dev@lists.freedesktop.org
Subject: Re: [igt-dev] [RFC PATCH v3 4/5] igt/core: Initial simple interleaved kmsg filtering
Date: Tue, 20 Feb 2018 12:50:45 +0100	[thread overview]
Message-ID: <20180220115045.GO22199@phenom.ffwll.local> (raw)
In-Reply-To: <20180220113041.18520-1-petri.latvala@intel.com>

On Tue, Feb 20, 2018 at 01:30:41PM +0200, Petri Latvala wrote:
> From: Daniel Vetter <daniel.vetter@ffwll.ch>
> 
> Needs to be beefed up so that dmesg warning (and worse) are re-emmitted
> as IGT_LOG_WARN. But only if they match one of our filters (which we
> should probably allow to be extended, e.g. depending upon which driver
> has been openened). This also requires that we at least parse the
> basic of kmsg lines (adjusting the timestamp to match our own would be
> real cool).
> 
> v2:
> - Seek to the end of the kmsg buffer before starting the capturing.
> - Increase linebuffer to avoid dmesg drowning out all the tests
>   messages.
> 
> v3: Unlazy slightly and implement semi-correct kmsg parsing.
> 
> v4 (Petri): Handle continuation lines instead of crashing on them
> 
> Signed-off-by: Daniel Vetter <daniel.vetter@ffwll.ch>
> Signed-off-by: Petri Latvala <petri.latvala@intel.com>
> ---
>  lib/igt_core.c | 65 +++++++++++++++++++++++++++++++++++++++++++++++++++++++++-
>  1 file changed, 64 insertions(+), 1 deletion(-)
> 
> diff --git a/lib/igt_core.c b/lib/igt_core.c
> index aaafc1df..27686276 100644
> --- a/lib/igt_core.c
> +++ b/lib/igt_core.c
> @@ -293,7 +293,7 @@ static const char *command_str;
>  
>  static char* igt_debug_log_domain_filter;
>  static struct {
> -	char *entries[256];
> +	char *entries[2000];
>  	uint8_t start, end;
>  } log_buffer;
>  static pthread_mutex_t log_buffer_mutex = PTHREAD_MUTEX_INITIALIZER;
> @@ -581,6 +581,67 @@ static void oom_adjust_for_doom(void)
>  
>  }
>  
> +static void *kmsg_capture(void *arg)
> +{
> +	int kmsg_capture_fd = (uintptr_t) arg;
> +	FILE *kmsg_file = fdopen(kmsg_capture_fd, "r");
> +	char *line = NULL;
> +	size_t line_len = 0;
> +	ssize_t read;

Please add

	/* See Documentation/ABI/testing/dev-kmsg in the kernel sources */

for dummies like me who tried to reverse-engineer the uapi from the
chardev sources :-)

> +
> +	while ((read = getline(&line, &line_len, kmsg_file))) {
> +		int s;
> +		unsigned flags;
> +		unsigned long long seq, ts_usec;
> +		char continuation;
> +		enum igt_log_level level;

Reading docs we also need to handle -EPIPE:
		if (read == -1)
			if (errno = EPIPE)
				continue; /* we can get -EPIPE on buffer overflow */
			else
				break;

With those 2 changes Reviewed-by: Daniel Vetter <daniel.vetter@ffwll.ch>
on your version.

Thanks for testing this.
-Daniel

> +
> +		s = sscanf(line, "%u,%llu,%llu,%c;", &flags,
> +			   &seq, &ts_usec, &continuation);
> +
> +		if (s == 4) {
> +			if ((flags & 0x7) <= 4)
> +				level = IGT_LOG_WARN;
> +			else
> +				level = IGT_LOG_DEBUG;
> +
> +			igt_log("dmesg", level, "[%llu.%06llu], %s",
> +				ts_usec / 1000000,
> +				ts_usec % 1000000,
> +				index(line, ';') + 1);
> +		} else if (line[0] == ' ') {
> +			/* continuation line; ignore */
> +		} else {
> +			igt_warn("Cannot parse kmsg line: %s\n", line);
> +		}
> +	}
> +
> +	igt_warn("ran out of dmesg, this shouldn't happen\n");
> +
> +	free(line);
> +	fclose(kmsg_file);
> +	return NULL;
> +}
> +
> +static void start_kmsg_recording(void)
> +{
> +	static pthread_t kmsg_capture_thread;
> +	int kmsg_capture_fd;
> +
> +	kmsg_capture_fd = open("/dev/kmsg",
> +			       O_RDONLY | O_CLOEXEC);
> +
> +	if (kmsg_capture_fd < 0) {
> +		igt_info("no dmesg capturing\n");
> +		return;
> +	}
> +
> +	lseek(kmsg_capture_fd, 0, SEEK_END);
> +
> +	pthread_create(&kmsg_capture_thread, NULL,
> +		       kmsg_capture, (void *)(uintptr_t) kmsg_capture_fd);
> +}
> +
>  #ifdef HAVE_GLIB
>  static void common_init_config(void)
>  {
> @@ -814,6 +875,8 @@ out:
>  		kmsg(KERN_INFO "[IGT] %s: executing\n", command_str);
>  		print_version();
>  
> +		start_kmsg_recording();
> +
>  		sync();
>  		oom_adjust_for_doom();
>  		ftrace_dump_on_oops(true);
> -- 
> 2.11.0
> 

-- 
Daniel Vetter
Software Engineer, Intel Corporation
http://blog.ffwll.ch
_______________________________________________
igt-dev mailing list
igt-dev@lists.freedesktop.org
https://lists.freedesktop.org/mailman/listinfo/igt-dev

  reply	other threads:[~2018-02-20 11:50 UTC|newest]

Thread overview: 12+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2018-01-18 13:59 [igt-dev] [RFC PATCH 1/5] tests/sw_sync: use igt_fork_helper Daniel Vetter
2018-01-18 13:59 ` [igt-dev] [RFC PATCH 2/5] lib/core: make logging pthread vs. fork safe Daniel Vetter
2018-01-18 13:59 ` [igt-dev] [RFC PATCH 3/5] lib/core: Don't hide non-debug message when filtering for a debug log domain Daniel Vetter
2018-01-18 13:59 ` [igt-dev] [RFC PATCH 4/5] igt/core: Initial simple interleaved kmsg filtering Daniel Vetter
2018-01-18 14:27   ` [igt-dev] [RFC PATCH] " Daniel Vetter
2018-02-20 11:30     ` [igt-dev] [RFC PATCH v3 4/5] " Petri Latvala
2018-02-20 11:50       ` Daniel Vetter [this message]
2018-02-20 12:09         ` Daniel Vetter
2018-01-18 13:59 ` [igt-dev] [RFC PATCH 5/5] lib/core: report subtests that hit an igt_warning as WARNING Daniel Vetter
2018-01-18 14:21 ` [igt-dev] ✓ Fi.CI.BAT: success for series starting with [RFC,1/5] tests/sw_sync: use igt_fork_helper Patchwork
2018-01-18 15:05 ` [igt-dev] ✗ Fi.CI.BAT: failure for series starting with [RFC,1/5] tests/sw_sync: use igt_fork_helper (rev2) Patchwork
2018-02-20 15:22 ` [igt-dev] ✗ Fi.CI.BAT: warning for series starting with [RFC,1/5] tests/sw_sync: use igt_fork_helper (rev3) Patchwork

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=20180220115045.GO22199@phenom.ffwll.local \
    --to=daniel@ffwll.ch \
    --cc=igt-dev@lists.freedesktop.org \
    --cc=petri.latvala@intel.com \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox