From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: from mp12.migadu.com ([2001:41d0:2:4a6f::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by ms5.migadu.com with LMTPS id MEAKJhiI/GPQDQAAbAwnHQ (envelope-from ) for ; Mon, 27 Feb 2023 11:38:16 +0100 Received: from aspmx1.migadu.com ([2001:41d0:2:4a6f::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by mp12.migadu.com with LMTPS id YNrvJRiI/GNhMgEAauVa8A (envelope-from ) for ; Mon, 27 Feb 2023 11:38:16 +0100 Received: from lists.gnu.org (lists.gnu.org [209.51.188.17]) (using TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)) (No client certificate requested) by aspmx1.migadu.com (Postfix) with ESMTPS id EF8022936E for ; Mon, 27 Feb 2023 11:38:15 +0100 (CET) Authentication-Results: aspmx1.migadu.com; dkim=fail ("headers rsa verify failed") header.d=gnu.org header.s=fencepost-gnu-org header.b=mlst+oxl; spf=pass (aspmx1.migadu.com: domain of "bug-guix-bounces+larch=yhetil.org@gnu.org" designates 209.51.188.17 as permitted sender) smtp.mailfrom="bug-guix-bounces+larch=yhetil.org@gnu.org"; dmarc=pass (policy=none) header.from=gnu.org ARC-Seal: i=1; s=key1; d=yhetil.org; t=1677494296; a=rsa-sha256; cv=none; b=WOsAluxAVXNK+zOjhYC8rupSsS/GDvrNLVV83OVLO3YNbovuycSQZ4mVJYGvY1csAyheT6 UxZiCgtBDJPYLFRLzsxmYH/8qU00oF+bI5ayaJ6EU0rNXzUryZp8VPlfv2aw6QbwyGb+g3 hIbkdwmO1MZxKV7Trgyz5Qz1Zfc4qVK4ExamOyt+N2YpO4yJ5d0b+TgMKH0Zgabkg77993 q4mBHtZpP8ctwCz4QZUjdPC4FuPMBgJ/as5E5yYpWUtApS5mw69ngDrLJ80lxQSYXq9hct P7q3/K/RZIyYheQNW/HQlwzHVU3Z5knOSNioai627XnyNtsjRWeQ6ze4X4uxDQ== ARC-Authentication-Results: i=1; aspmx1.migadu.com; dkim=fail ("headers rsa verify failed") header.d=gnu.org header.s=fencepost-gnu-org header.b=mlst+oxl; spf=pass (aspmx1.migadu.com: domain of "bug-guix-bounces+larch=yhetil.org@gnu.org" designates 209.51.188.17 as permitted sender) smtp.mailfrom="bug-guix-bounces+larch=yhetil.org@gnu.org"; dmarc=pass (policy=none) header.from=gnu.org ARC-Message-Signature: i=1; a=rsa-sha256; c=relaxed/relaxed; d=yhetil.org; s=key1; t=1677494296; h=from:from:sender:sender:reply-to:subject:subject:date:date: message-id:message-id:to:to:cc:cc:mime-version:mime-version: content-type:content-type: content-transfer-encoding:content-transfer-encoding:resent-cc: resent-from:resent-sender:resent-message-id:list-id:list-help: list-unsubscribe:list-subscribe:list-post:dkim-signature; bh=gFYGy5VJddheBiQLAVNYVs12BiehJcywFkEnng7brHo=; b=RZT6wYvCJeIA3HgL8HerkfIxnYOZrY0/xsWIbyPUlhffHaig/+pvbUVNRC1MSesWHtVnoY T94yttb9vr74ns/5AwuOsel7dPDZgKTaYBwgvZkiK9kxjH3YY5mwlKltrCjJNC7cf3MtGu 5Jw245mR2C2NoV+tRWbCS3dUupYzXQW4To9fRoPMlVc25HC+AW+foedFGmHsTK+KPcHhef EgY3BWS4OxQP4IDSRMSDv/+uEGmMO4YpDbmjbgieEYdnyUwm+EwH2qVBLMYronRBeXgfkP EEy0UPjewgxs0c8fqgPgsbCA1kwsTtTFTVwRP7aD8fvx5E8NDnvSOXXthvfjJA== Received: from localhost ([::1] helo=lists1p.gnu.org) by lists.gnu.org with esmtp (Exim 4.90_1) (envelope-from ) id 1pWatQ-00042O-KK; Mon, 27 Feb 2023 05:38:04 -0500 Received: from eggs.gnu.org ([2001:470:142:3::10]) by lists.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256) (Exim 4.90_1) (envelope-from ) id 1pWatO-00041H-Rw for bug-guix@gnu.org; Mon, 27 Feb 2023 05:38:02 -0500 Received: from debbugs.gnu.org ([209.51.188.43]) by eggs.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_128_GCM_SHA256:128) (Exim 4.90_1) (envelope-from ) id 1pWatO-0002tL-Jh; Mon, 27 Feb 2023 05:38:02 -0500 Received: from Debian-debbugs by debbugs.gnu.org with local (Exim 4.84_2) (envelope-from ) id 1pWatO-0001kK-7M; Mon, 27 Feb 2023 05:38:02 -0500 X-Loop: help-debbugs@gnu.org Subject: bug#61839: [Cuirass] Build timeouts during evaluations Resent-From: Ludovic =?UTF-8?Q?Court=C3=A8s?= Original-Sender: "Debbugs-submit" Resent-CC: othacehe@gnu.org, bug-guix@gnu.org Resent-Date: Mon, 27 Feb 2023 10:38:02 +0000 Resent-Message-ID: Resent-Sender: help-debbugs@gnu.org X-GNU-PR-Message: report 61839 X-GNU-PR-Package: guix X-GNU-PR-Keywords: To: 61839@debbugs.gnu.org Cc: Mathieu Othacehe X-Debbugs-Original-To: bug-guix@gnu.org X-Debbugs-Original-Xcc: Mathieu Othacehe Received: via spool by submit@debbugs.gnu.org id=B.16774942756699 (code B ref -1); Mon, 27 Feb 2023 10:38:02 +0000 Received: (at submit) by debbugs.gnu.org; 27 Feb 2023 10:37:55 +0000 Received: from localhost ([127.0.0.1]:46185 helo=debbugs.gnu.org) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1pWatH-0001jy-53 for submit@debbugs.gnu.org; Mon, 27 Feb 2023 05:37:55 -0500 Received: from lists.gnu.org ([209.51.188.17]:34636) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1pWatF-0001jr-Fp for submit@debbugs.gnu.org; Mon, 27 Feb 2023 05:37:54 -0500 Received: from eggs.gnu.org ([2001:470:142:3::10]) by lists.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256) (Exim 4.90_1) (envelope-from ) id 1pWatE-0003vy-TT for bug-guix@gnu.org; Mon, 27 Feb 2023 05:37:53 -0500 Received: from fencepost.gnu.org ([2001:470:142:3::e]) by eggs.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256) (Exim 4.90_1) (envelope-from ) id 1pWatE-0002qy-Li for bug-guix@gnu.org; Mon, 27 Feb 2023 05:37:52 -0500 DKIM-Signature: v=1; a=rsa-sha256; q=dns/txt; c=relaxed/relaxed; d=gnu.org; s=fencepost-gnu-org; h=MIME-Version:Date:Subject:To:From:in-reply-to: references; bh=gFYGy5VJddheBiQLAVNYVs12BiehJcywFkEnng7brHo=; b=mlst+oxlzfZNyN FEyT7dPdMoH4tbd5BA4JaoHCFMDSgIOffVyRp7WyO8Eu3IUzVQ5QKKU7niv+83c15P0flSm+oMSBk eJONWnNRokno3djViYoxH2CqITBHjiodZpj/IKc+bH/QV76NfSjk6l2SheOHOK/lOLkejwURNw/wC aMfY8KYpyop2Y2FQR5HF9ODoYGq1UJHI+fBOcWzISTsMd15wGAqSiRwTtY7tdfiJkNSGlf7SuicxT TMR8L8JmCy3fbKJE9IXjP9L8VfGB7Mk15mPcGq+B+JMoEW9goIN/e9VGkUYSE7O4fJiv/duei7XNB EZn62V/dvMM88BajuCGw==; Received: from [2001:660:6102:320:e120:2c8f:8909:cdfe] (helo=ribbon) by fencepost.gnu.org with esmtpsa (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256) (Exim 4.90_1) (envelope-from ) id 1pWatE-0007Ox-2o for bug-guix@gnu.org; Mon, 27 Feb 2023 05:37:52 -0500 From: Ludovic =?UTF-8?Q?Court=C3=A8s?= X-URL: http://www.fdn.fr/~lcourtes/ X-Revolutionary-Date: Nonidi 9 =?UTF-8?Q?Vent=C3=B4se?= an 231 de la =?UTF-8?Q?R=C3=A9volution,?= jour du Marsault 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: Mon, 27 Feb 2023 11:37:49 +0100 Message-ID: <87a60zo0le.fsf@inria.fr> User-Agent: Gnus/5.13 (Gnus v5.13) Emacs/28.2 (gnu/linux) MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable X-BeenThere: debbugs-submit@debbugs.gnu.org X-Mailman-Version: 2.1.18 Precedence: list X-BeenThere: bug-guix@gnu.org List-Id: Bug reports for GNU Guix List-Unsubscribe: , List-Archive: List-Post: X-Migadu-Queue-Id: EF8022936E X-Spam-Score: -3.99 X-Migadu-Spam-Score: -3.99 X-Migadu-Scanner: scn0.migadu.com List-Help: List-Subscribe: , Errors-To: bug-guix-bounces+larch=yhetil.org@gnu.org Sender: bug-guix-bounces+larch=yhetil.org@gnu.org X-Migadu-Flow: FLOW_IN X-Migadu-Country: US X-TUID: m10vBS9PBrkZ Hello Guix! We often get evaluation errors for =E2=80=98core-updates=E2=80=99, where th= e build log reveals that this is due to a build timeout while building the Guix instance that will be used for the evaluation. Example: --8<---------------cut here---------------start------------->8--- building of `/gnu/store/x9dyzywwmsp8vmpvpx54yhcnz7rqin0l-asciidoc-9.1.0.drv= ' timed out after 3600 seconds of silence cannot build derivation `/gnu/store/bl7aq8999lmp6flbyw3k656m522jmcl3-git-2.= 39.1.drv': 1 dependencies couldn't be built cannot build derivation `/gnu/store/ldajjyvb4np1zq9l9s09j0dpsbpscpan-gnulib= -2022-12-06-1.440b528.drv': 1 dependencies couldn't be built cannot build derivation `/gnu/store/fdks470j7xjw3dc6fiyw15hdsxj6cdbc-guile-= gnutls-3.7.11.drv': 1 dependencies couldn't be built cannot build derivation `/gnu/store/71pl6a38bd0b81qgi45wz2ymvlv0x7xn-guix-c= li-core.drv': 1 dependencies couldn't be built [...] cannot build derivation `/gnu/store/m7r73wypxhhmv8cqza1x8g2zyq9k1xpg-profil= e.drv': 1 dependencies couldn't be built [...] ERROR: 1. &store-protocol-error: message: "build of `/gnu/store/m7r73wypxhhmv8cqza1x8g2zyq9k1xpg-profi= le.drv' failed" status: 101 --8<---------------cut here---------------end--------------->8--- (From .) Likewise for the =E2=80=98guile=E2=80=99 jobset: --8<---------------cut here---------------start------------->8--- exporting path `/gnu/store/m2hyx7qk2j1bsvpj1qv89701klv8kqkk-guix-command' exporting path `/gnu/store/vlm7401d5jvna6j7qdxhcr581cd8g8vh-guix-daemon-1.4= .0-4.01fd830' exporting path `/gnu/store/zv3c0anfj085d2lyxh4g4aahhczmcaj8-guix-daemon' exporting path `/gnu/store/f26rw4haizf2h126k9ja9wk31cm49mj0-guix-17bd02433' exporting path `/gnu/store/wc736va72zl2zz36817ahf3kc5fkfr69-inferior-script= .scm' building of `/gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv' timed o= ut after 3600 seconds of silence cannot build derivation `/gnu/store/nrcsvww8j24rjzyin90w76qgbkgphhvp-profil= e.drv': 1 dependencies couldn't be built Backtrace: In ice-9/boot-9.scm: 1752:10 12 (with-exception-handler _ _ #:unwind? _ # _) In unknown file: 11 (apply-smob/0 #) In ice-9/boot-9.scm: 724:2 10 (call-with-prompt _ _ #) In ice-9/eval.scm: 619:8 9 (_ #(#(#))) In cuirass/ui.scm: 104:10 8 (run-cuirass-command _ . _) In cuirass/scripts/evaluate.scm: 105:27 7 (cuirass-evaluate _) In ice-9/boot-9.scm: 1752:10 6 (with-exception-handler _ _ #:unwind? _ # _) In guix/store.scm: 658:37 5 (thunk) 2123:25 4 (run-with-store # ?) In cuirass/scripts/evaluate.scm: 87:8 3 (_ _) In guix/store.scm: 1995:38 2 (_ #) 1421:15 1 (_ # _ _) In ice-9/boot-9.scm: 1685:16 0 (raise-exception _ #:continuable? _) ice-9/boot-9.scm:1685:16: In procedure raise-exception: ERROR: 1. &store-protocol-error: message: "build of `/gnu/store/nrcsvww8j24rjzyin90w76qgbkgphhvp-profi= le.drv' failed" status: 101 --8<---------------cut here---------------end--------------->8--- Building this particular derivation is quick though: --8<---------------cut here---------------start------------->8--- $ time guix build /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv --c= heck The following derivation will be built: /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv building /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv... (repl-version 0 1 1) (values (value "/gnu/store/rgk1sc2zvllf7cgbyj5g28b9v2x6nvn3-guile/share/gui= le/site/3.0")) successfully built /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv successfully built /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv /gnu/store/rgk1sc2zvllf7cgbyj5g28b9v2x6nvn3-guile real 0m1.253s user 0m0.751s sys 0m0.034s --8<---------------cut here---------------end--------------->8--- So the problem must be elsewhere. One thing is that this particular .drv is quite big: --8<---------------cut here---------------start------------->8--- $ guix size /gnu/store/yq9r44lic8cn4nphksbi5s3ppwfcsh1n-guile.drv store item total s= elf /gnu/store/wjr1sqxci75jfkvwzmmvlgypkyp3fvqi-guix-17bd024 105.0 = 105.0 42.9% /gnu/store/6b3fp2kwqxw7cvnh6jz9g49n9k2n5avy-guix-packages-base-source 36= .2 36.2 14.8% /gnu/store/h3hjni2bd8f5kbn8w0g2xx2jnagfynnr-guile-e2ed33e 29.0 = 29.0 11.8% /gnu/store/gfb26xn5f2qyrxzv847cd6iql6h8igh0-packages 23.1 = 23.1 9.4% /gnu/store/dj8rq4jd8qgk4k1hzg8djcvi6hlbdb7m-doc 22.3 = 22.3 9.1% /gnu/store/a5z192qxni40ly92cknwxkpnxc8zxfgf-guix 7.8 = 7.8 3.2% /gnu/store/f8wg2y3rrh4dgi6znjrv8a1l4ymkc7rb-guix-packages-source 2.8 = 2.8 1.2% /gnu/store/8iwm8x6472xnf7g6hfxzw029gxm1qbkq-guix-system-source 2.5 = 2.5 1.0% /gnu/store/2dxbf11shgvs1cgvzz6wpnfra97f0sfw-guix-extra-source 2.5 = 2.5 1.0% /gnu/store/q57az26zdgafic5b8xsbxlh4iwddvr86-doc 2.1 = 2.1 0.9% [=E2=80=A6] /gnu/store/0mxnx8l4fgigvd7gakwdk6hc6im4wnai-disarchive-mirrors 0.0 = 0.0 0.0% total: 244.8 MiB --8<---------------cut here---------------end--------------->8--- Merely transferring it for offloading takes time; depending on machine load, perhaps it can hit the 1h max-silent timeout? That=E2=80=99d mean the throughput is below 70=C2=A0KiB/s. Plausible? The closure of /gnu/store/x9dyzywwmsp8vmpvpx54yhcnz7rqin0l-asciidoc-9.1.0.drv is 3.0=C2=A0MiB and it builds in 4 seconds, so there must be something else going on, perhaps a bug in libssh/Guile-SSH leading to stale connections? Thoughts? Ludo=E2=80=99.