GNU bug report logs - #36510
confusing mcron logging

Please note: This is a static page, with minimal formatting, updated once a day.
Click here to see this page with the latest information and nicer formatting.
Package: guix; Reported by: Robert Vollmert <rob@HIDDEN>; dated Fri, 5 Jul 2019 13:37:01 UTC; Maintainer for guix is bug-guix@HIDDEN.

Message received at 36510 <at> debbugs.gnu.org:


Received: (at 36510) by debbugs.gnu.org; 5 Jul 2019 20:49:33 +0000
From debbugs-submit-bounces <at> debbugs.gnu.org Fri Jul 05 16:49:33 2019
Received: from localhost ([127.0.0.1]:53855 helo=debbugs.gnu.org)
	by debbugs.gnu.org with esmtp (Exim 4.84_2)
	(envelope-from <debbugs-submit-bounces <at> debbugs.gnu.org>)
	id 1hjV99-0000Yd-4T
	for submit <at> debbugs.gnu.org; Fri, 05 Jul 2019 16:49:31 -0400
Received: from mx1.mailbox.org ([80.241.60.212]:51054)
 by debbugs.gnu.org with esmtp (Exim 4.84_2)
 (envelope-from <rob@HIDDEN>) id 1hjV97-0000YQ-8N
 for 36510 <at> debbugs.gnu.org; Fri, 05 Jul 2019 16:49:29 -0400
Received: from smtp2.mailbox.org (smtp2.mailbox.org [80.241.60.241])
 (using TLSv1.2 with cipher ECDHE-RSA-CHACHA20-POLY1305 (256/256 bits))
 (No client certificate requested)
 by mx1.mailbox.org (Postfix) with ESMTPS id C25134FC62;
 Fri,  5 Jul 2019 22:49:22 +0200 (CEST)
X-Virus-Scanned: amavisd-new at heinlein-support.de
Received: from smtp2.mailbox.org ([80.241.60.241])
 by spamfilter01.heinlein-hosting.de (spamfilter01.heinlein-hosting.de
 [80.241.56.115]) (amavisd-new, port 10030)
 with ESMTP id 3QUZywfbc0tb; Fri,  5 Jul 2019 22:48:58 +0200 (CEST)
Content-Type: text/plain;
	charset=utf-8
Mime-Version: 1.0 (Mac OS X Mail 12.4 \(3445.104.11\))
Subject: Re: bug#36510: confusing mcron logging
From: Robert Vollmert <rob@HIDDEN>
In-Reply-To: <87r274jjyy.fsf@HIDDEN>
Date: Fri, 5 Jul 2019 22:48:57 +0200
Content-Transfer-Encoding: quoted-printable
Message-Id: <4E575636-A350-48C0-A20F-6DE7AEB2D5AF@HIDDEN>
References: <90FD0C85-F140-420C-AD90-3C2776D8B8D0@HIDDEN>
 <87r274jjyy.fsf@HIDDEN>
To: =?utf-8?Q?Ludovic_Court=C3=A8s?= <ludo@HIDDEN>
X-Spam-Score: -0.7 (/)
X-Debbugs-Envelope-To: 36510
Cc: 36510 <at> debbugs.gnu.org
X-BeenThere: debbugs-submit <at> debbugs.gnu.org
X-Mailman-Version: 2.1.18
Precedence: list
List-Id: <debbugs-submit.debbugs.gnu.org>
List-Unsubscribe: <https://debbugs.gnu.org/cgi-bin/mailman/options/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=unsubscribe>
List-Archive: <https://debbugs.gnu.org/cgi-bin/mailman/private/debbugs-submit/>
List-Post: <mailto:debbugs-submit <at> debbugs.gnu.org>
List-Help: <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=help>
List-Subscribe: <https://debbugs.gnu.org/cgi-bin/mailman/listinfo/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=subscribe>
Errors-To: debbugs-submit-bounces <at> debbugs.gnu.org
Sender: "Debbugs-submit" <debbugs-submit-bounces <at> debbugs.gnu.org>
X-Spam-Score: -1.7 (-)

> On 5. Jul 2019, at 22:37, Ludovic Court=C3=A8s <ludo@HIDDEN> wrote:
> Something that can help debugging to some extent (but is definitely no
> substitute for what you suggest above!) is =E2=80=98sudo herd schedule =
mcron=E2=80=99.
> I use that to manually run jobs that appear not to work as expected.

That only works for non-guile jobs though as far as I understand, where
'herd schedule mcron' prints a store path.

https://debbugs.gnu.org/cgi/bugreport.cgi?bug=3D36430
Information forwarded to bug-guix@HIDDEN:
bug#36510; Package guix. Full text available.

Message received at 36510 <at> debbugs.gnu.org:


Received: (at 36510) by debbugs.gnu.org; 5 Jul 2019 20:38:10 +0000
From debbugs-submit-bounces <at> debbugs.gnu.org Fri Jul 05 16:38:10 2019
Received: from localhost ([127.0.0.1]:53842 helo=debbugs.gnu.org)
	by debbugs.gnu.org with esmtp (Exim 4.84_2)
	(envelope-from <debbugs-submit-bounces <at> debbugs.gnu.org>)
	id 1hjUyA-0000EW-Ep
	for submit <at> debbugs.gnu.org; Fri, 05 Jul 2019 16:38:10 -0400
Received: from eggs.gnu.org ([209.51.188.92]:53351)
 by debbugs.gnu.org with esmtp (Exim 4.84_2)
 (envelope-from <ludo@HIDDEN>) id 1hjUy7-0000E5-RO
 for 36510 <at> debbugs.gnu.org; Fri, 05 Jul 2019 16:38:08 -0400
Received: from fencepost.gnu.org ([2001:470:142:3::e]:41613)
 by eggs.gnu.org with esmtp (Exim 4.71) (envelope-from <ludo@HIDDEN>)
 id 1hjUxz-0005oU-SZ; Fri, 05 Jul 2019 16:38:00 -0400
Received: from [2a01:e0a:1d:7270:af76:b9b:ca24:c465] (port=50240 helo=ribbon)
 by fencepost.gnu.org with esmtpsa (TLS1.2:RSA_AES_256_CBC_SHA1:256)
 (Exim 4.82) (envelope-from <ludo@HIDDEN>)
 id 1hjUxz-0003be-AT; Fri, 05 Jul 2019 16:37:59 -0400
From: =?utf-8?Q?Ludovic_Court=C3=A8s?= <ludo@HIDDEN>
To: Robert Vollmert <rob@HIDDEN>
Subject: Re: bug#36510: confusing mcron logging
References: <90FD0C85-F140-420C-AD90-3C2776D8B8D0@HIDDEN>
X-URL: http://www.fdn.fr/~lcourtes/
X-Revolutionary-Date: 17 Messidor an 227 de la =?utf-8?Q?R=C3=A9volution?=
X-PGP-Key-ID: 0x090B11993D9AEBB5
X-PGP-Key: http://www.fdn.fr/~lcourtes/ludovic.asc
X-PGP-Fingerprint: 3CE4 6455 8A84 FDC6 9DB4  0CFB 090B 1199 3D9A EBB5
X-OS: x86_64-pc-linux-gnu
Date: Fri, 05 Jul 2019 22:37:57 +0200
In-Reply-To: <90FD0C85-F140-420C-AD90-3C2776D8B8D0@HIDDEN> (Robert
 Vollmert's message of "Fri, 5 Jul 2019 15:35:35 +0200")
Message-ID: <87r274jjyy.fsf@HIDDEN>
User-Agent: Gnus/5.13 (Gnus v5.13) Emacs/26.2 (gnu/linux)
MIME-Version: 1.0
Content-Type: text/plain; charset=utf-8
Content-Transfer-Encoding: quoted-printable
X-detected-operating-system: by eggs.gnu.org: GNU/Linux 2.2.x-3.x [generic]
X-Spam-Score: -2.3 (--)
X-Debbugs-Envelope-To: 36510
Cc: 36510 <at> debbugs.gnu.org
X-BeenThere: debbugs-submit <at> debbugs.gnu.org
X-Mailman-Version: 2.1.18
Precedence: list
List-Id: <debbugs-submit.debbugs.gnu.org>
List-Unsubscribe: <https://debbugs.gnu.org/cgi-bin/mailman/options/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=unsubscribe>
List-Archive: <https://debbugs.gnu.org/cgi-bin/mailman/private/debbugs-submit/>
List-Post: <mailto:debbugs-submit <at> debbugs.gnu.org>
List-Help: <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=help>
List-Subscribe: <https://debbugs.gnu.org/cgi-bin/mailman/listinfo/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=subscribe>
Errors-To: debbugs-submit-bounces <at> debbugs.gnu.org
Sender: "Debbugs-submit" <debbugs-submit-bounces <at> debbugs.gnu.org>
X-Spam-Score: -3.3 (---)

Hi,

Robert Vollmert <rob@HIDDEN> skribis:

> Suggestions:
> - mcron should log the timestamp and a job id of every job when it starts
> - mcron should log the timestamp and status and job id of every job when =
it finishes
> - job output should be prefixed by some job id

+1!  +3 even.  :-)

Something that can help debugging to some extent (but is definitely no
substitute for what you suggest above!) is =E2=80=98sudo herd schedule mcro=
n=E2=80=99.
I use that to manually run jobs that appear not to work as expected.

Ludo=E2=80=99.
Information forwarded to bug-guix@HIDDEN:
bug#36510; Package guix. Full text available.

Message received at submit <at> debbugs.gnu.org:


Received: (at submit) by debbugs.gnu.org; 5 Jul 2019 13:36:03 +0000
From debbugs-submit-bounces <at> debbugs.gnu.org Fri Jul 05 09:36:03 2019
Received: from localhost ([127.0.0.1]:52520 helo=debbugs.gnu.org)
	by debbugs.gnu.org with esmtp (Exim 4.84_2)
	(envelope-from <debbugs-submit-bounces <at> debbugs.gnu.org>)
	id 1hjONe-0001Nh-Js
	for submit <at> debbugs.gnu.org; Fri, 05 Jul 2019 09:36:02 -0400
Received: from lists.gnu.org ([209.51.188.17]:33193)
 by debbugs.gnu.org with esmtp (Exim 4.84_2)
 (envelope-from <rob@HIDDEN>) id 1hjONb-0001NG-3W
 for submit <at> debbugs.gnu.org; Fri, 05 Jul 2019 09:36:00 -0400
Received: from eggs.gnu.org ([2001:470:142:3::10]:39183)
 by lists.gnu.org with esmtp (Exim 4.86_2)
 (envelope-from <rob@HIDDEN>) id 1hjONY-0002yh-U7
 for bug-guix@HIDDEN; Fri, 05 Jul 2019 09:35:59 -0400
X-Spam-Checker-Version: SpamAssassin 3.3.2 (2011-06-06) on eggs.gnu.org
X-Spam-Level: 
X-Spam-Status: No, score=0.8 required=5.0 tests=BAYES_50,URIBL_BLOCKED
 autolearn=disabled version=3.3.2
Received: from Debian-exim by eggs.gnu.org with spam-scanned (Exim 4.71)
 (envelope-from <rob@HIDDEN>) id 1hjONU-0001ja-Q1
 for bug-guix@HIDDEN; Fri, 05 Jul 2019 09:35:54 -0400
Received: from mx1.mailbox.org ([2001:67c:2050:104:0:1:25:1]:9894)
 by eggs.gnu.org with esmtps (TLS1.0:RSA_AES_256_CBC_SHA1:32)
 (Exim 4.71) (envelope-from <rob@HIDDEN>) id 1hjONT-00015G-MC
 for bug-guix@HIDDEN; Fri, 05 Jul 2019 09:35:52 -0400
Received: from smtp2.mailbox.org (smtp2.mailbox.org [80.241.60.241])
 (using TLSv1.2 with cipher ECDHE-RSA-CHACHA20-POLY1305 (256/256 bits))
 (No client certificate requested)
 by mx1.mailbox.org (Postfix) with ESMTPS id 6F26E50984
 for <bug-guix@HIDDEN>; Fri,  5 Jul 2019 15:35:43 +0200 (CEST)
X-Virus-Scanned: amavisd-new at heinlein-support.de
Received: from smtp2.mailbox.org ([80.241.60.241])
 by spamfilter05.heinlein-hosting.de (spamfilter05.heinlein-hosting.de
 [80.241.56.123]) (amavisd-new, port 10030)
 with ESMTP id bd6eR5pnCBQG for <bug-guix@HIDDEN>;
 Fri,  5 Jul 2019 15:35:36 +0200 (CEST)
From: Robert Vollmert <rob@HIDDEN>
Content-Type: text/plain;
	charset=utf-8
Content-Transfer-Encoding: quoted-printable
Mime-Version: 1.0 (Mac OS X Mail 12.4 \(3445.104.11\))
Subject: confusing mcron logging
Message-Id: <90FD0C85-F140-420C-AD90-3C2776D8B8D0@HIDDEN>
Date: Fri, 5 Jul 2019 15:35:35 +0200
To: bug-guix@HIDDEN
X-detected-operating-system: by eggs.gnu.org: Genre and OS details not
 recognized.
X-Received-From: 2001:67c:2050:104:0:1:25:1
X-Spam-Score: -1.6 (-)
X-Debbugs-Envelope-To: submit
X-BeenThere: debbugs-submit <at> debbugs.gnu.org
X-Mailman-Version: 2.1.18
Precedence: list
List-Id: <debbugs-submit.debbugs.gnu.org>
List-Unsubscribe: <https://debbugs.gnu.org/cgi-bin/mailman/options/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=unsubscribe>
List-Archive: <https://debbugs.gnu.org/cgi-bin/mailman/private/debbugs-submit/>
List-Post: <mailto:debbugs-submit <at> debbugs.gnu.org>
List-Help: <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=help>
List-Subscribe: <https://debbugs.gnu.org/cgi-bin/mailman/listinfo/debbugs-submit>, 
 <mailto:debbugs-submit-request <at> debbugs.gnu.org?subject=subscribe>
Errors-To: debbugs-submit-bounces <at> debbugs.gnu.org
Sender: "Debbugs-submit" <debbugs-submit-bounces <at> debbugs.gnu.org>
X-Spam-Score: -2.6 (--)

I have two mcron jobs on my system, certbot renewal and
a handwritten and currently buggy guile job. This is an
excerpt from /var/log/mcron.log:

>>>>>

Saving debug log to /var/log/letsencrypt/letsencrypt.log
Plugins selected: Authenticator webroot, Installer None
Cert not yet due for renewal
Keeping the existing certificate

- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Certificate not yet due for renewal; no action taken.
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Acquiring or renewing certificate: garp.vllmrt.net
Saving debug log to /var/log/letsencrypt/letsencrypt.log
Plugins selected: Authenticator webroot, Installer None
Cert not yet due for renewal
Keeping the existing certificate

- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Certificate not yet due for renewal; no action taken.
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Acquiring or renewing certificate: garp.vllmrt.net
Backtrace:
           9 (apply-smob/1 #<catch-closure 5cf300>)
In ice-9/boot-9.scm:
    829:9  8 (catch mcron-error #<procedure 7fe67c318d28 at mcron/s?> ?)
In mcron/scripts/mcron.scm:
     99:7  7 (_)
In mcron/base.scm:
   234:12  6 (_ #<continuation 5ad660>)
In srfi/srfi-1.scm:
    640:9  5 (for-each #<procedure run-job (job)> (#<<job> user: #(?>))
In mcron/base.scm:
   186:10  4 (run-job #<<job> user: #("root" "x" 0 0 "System adminis?>)
In ice-9/eval.scm:
   293:34  3 (_ #(#(#<directory (mcron scripts mcron) 6a9c80>)))
   182:19  2 (proc #(#(#<directory (mcron scripts mcron) 6a9c80>)))
   142:16  1 (compile-top-call _ (7 . get-string-all) ((10 (# . #) ?)))
In unknown file:
           0 (%resolve-variable (7 . get-string-all) #<directory (mc?>)

ERROR: In procedure %resolve-variable:
Unbound variable: get-string-all
Saving debug log to /var/log/letsencrypt/letsencrypt.log
Plugins selected: Authenticator webroot, Installer None
Cert not yet due for renewal
Keeping the existing certificate

- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Certificate not yet due for renewal; no action taken.
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Acquiring or renewing certificate: garp.vllmrt.net
Saving debug log to /var/log/letsencrypt/letsencrypt.log
Plugins selected: Authenticator webroot, Installer None
Cert not yet due for renewal
Keeping the existing certificate

- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Certificate not yet due for renewal; no action taken.
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - =
- - - -
Acquiring or renewing certificate: garp.vllmrt.net

<<<<<

It=E2=80=99s impossible to tell what output is from which job; which =
jobs succeeded or
didn=E2=80=99t; when they ran.

Suggestions:
- mcron should log the timestamp and a job id of every job when it =
starts
- mcron should log the timestamp and status and job id of every job when =
it finishes
- job output should be prefixed by some job id
Acknowledgement sent to Robert Vollmert <rob@HIDDEN>:
New bug report received and forwarded. Copy sent to bug-guix@HIDDEN. Full text available.
Report forwarded to bug-guix@HIDDEN:
bug#36510; Package guix. Full text available.
Please note: This is a static page, with minimal formatting, updated once a day.
Click here to see this page with the latest information and nicer formatting.
Last modified: Mon, 25 Nov 2019 12:00:02 UTC

GNU bug tracking system
Copyright (C) 1999 Darren O. Benham, 1997 nCipher Corporation Ltd, 1994-97 Ian Jackson.