From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: from mp0.migadu.com ([2001:41d0:403:58f0::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by ms13.migadu.com with LMTPS id UFmMOHr6ZmeRUwAAqHPOHw:P1 (envelope-from ) for ; Sat, 21 Dec 2024 17:27:23 +0000 Received: from aspmx1.migadu.com ([2001:41d0:403:58f0::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by mp0.migadu.com with LMTPS id UFmMOHr6ZmeRUwAAqHPOHw (envelope-from ) for ; Sat, 21 Dec 2024 18:27:23 +0100 X-Envelope-To: larch@yhetil.org Authentication-Results: aspmx1.migadu.com; dkim=pass header.d=debbugs.gnu.org header.s=debbugs-gnu-org header.b=vD0JKrS4; dkim=fail ("headers rsa verify failed") header.d=gnu.org header.s=fencepost-gnu-org header.b=CTwvlSeg; 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=1734802042; 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:in-reply-to:in-reply-to: references:references:list-id:list-help:list-unsubscribe: list-subscribe:list-post:dkim-signature; bh=wzRm2Mb94YE1+SeYc9ondSLuc0rChA/NAzL/CoXZPwQ=; b=jo/64joPdVpRfxgqLoZvKGuPAjjVWPH7Ro5mItr1J4x4SYEErCVkC/691tjKkYuX/6qWTP 7HahZaUI1xcSlKVvpJAaJMXgDcspFQTkPwY6CxnLv2k2zjXdFsMQFfaRjZiSvwEP9npj5e sEFf35y6ruphlTVKqVQMBm1JKAOlbJDY9hdsN+dA0k4ayyW8TgRUoqxcRRV8rn9Cgen4IU MIc7wYF/+3LzOtobZxKPu4VX+ubsvZdPSNWgY4fkIbSzT4fubwgsJN020sQWUTu42JSMdK uwWohPs/0Yf7jZ1CXxawydCyS6v98QJbWPlmfrq14RzshKPIPKI26uPpoj3y2w== ARC-Authentication-Results: i=1; aspmx1.migadu.com; dkim=pass header.d=debbugs.gnu.org header.s=debbugs-gnu-org header.b=vD0JKrS4; dkim=fail ("headers rsa verify failed") header.d=gnu.org header.s=fencepost-gnu-org header.b=CTwvlSeg; 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=1734802042; a=rsa-sha256; cv=none; b=J09wAvYH/7Zg9lzUElfe4p+la6cca+ejDeGu8TTNd/Opa/JcehZjA3YitW6yZ+nt3NJEQr ICt/M5zGNTCTuY6bFhqKCCyvOWF7RgMuawFWIbWs6CQ2klDLU6vSezHJUNmbWzwYxgQNCD Py/UR7Pxdf38nJsvcCj0Hs78lQ3ZErlbN1QsUy9eSsSeYGI/vwxvQYQ4JaPIDuXdcohyDw Zje790lUe1bsE7pF5bmWzV9frRqaxuwEMhOTjMzsjRUe+myfUo14csayUGELZPzXwIs8sK sN8PXIAlcLWtvgMQDhTxzUc4OJdxQxE4yhBZvC5v5Q5KlhxWjnqiimw1Zo8K8A== 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 53F3390A7E for ; Sat, 21 Dec 2024 18:27:22 +0100 (CET) Received: from localhost ([::1] helo=lists1p.gnu.org) by lists.gnu.org with esmtp (Exim 4.90_1) (envelope-from ) id 1tP2yN-000614-Tm; Sat, 21 Dec 2024 12:09:03 -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 1tP2yM-00060w-RW for bug-guix@gnu.org; Sat, 21 Dec 2024 12:09:02 -0500 Received: from debbugs.gnu.org ([2001:470:142:5::43]) by eggs.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_128_GCM_SHA256:128) (Exim 4.90_1) (envelope-from ) id 1tP2yM-0004Fq-I6 for bug-guix@gnu.org; Sat, 21 Dec 2024 12:09:02 -0500 DKIM-Signature: v=1; a=rsa-sha256; q=dns/txt; c=relaxed/relaxed; d=debbugs.gnu.org; s=debbugs-gnu-org; h=MIME-Version:Date:References:In-Reply-To:From:To:Subject; bh=wzRm2Mb94YE1+SeYc9ondSLuc0rChA/NAzL/CoXZPwQ=; b=vD0JKrS4pqsQPFCbU5xHpZr5KnzGZwTUcz6LPZcWMRekQI9rGoMcQ3IhojObkXNthaQLitdQ/24IwbcfSgiQu/GBzjysYv1zY2zFPv8rh9qcsb+J6XpwOu8XjUrFdBVMVIpBoBTIugarza+wlFLLpAdqmSkNIX6mITS47QtLJKvtd1sUgcNFI4ivCaKqwE9FCpEEudd1J5UAyG9HTNLCS9/782eu1HdkbeGjI582OrtyAmZ8DQyuA8P9vHY2pVLaoSgZlDtcuNvpxjLwHnauC3VXsqzUnN9AfkFTRXUkN9l6pCxa//xFmdYGy1J5hG7celCHs8vKXc45iRRgggN2Pg==; Received: from Debian-debbugs by debbugs.gnu.org with local (Exim 4.84_2) (envelope-from ) id 1tP2yM-0005Wn-BO for bug-guix@gnu.org; Sat, 21 Dec 2024 12:09:02 -0500 X-Loop: help-debbugs@gnu.org Subject: bug#31785: Multiple client 'build-paths' RPCs can lead to daemon deadlock Resent-From: Ludovic =?UTF-8?Q?Court=C3=A8s?= Original-Sender: "Debbugs-submit" Resent-CC: bug-guix@gnu.org Resent-Date: Sat, 21 Dec 2024 17:09:02 +0000 Resent-Message-ID: Resent-Sender: help-debbugs@gnu.org X-GNU-PR-Message: followup 31785 X-GNU-PR-Package: guix X-GNU-PR-Keywords: To: 31785@debbugs.gnu.org Cc: Christopher Baines , Reepca Russelstein Received: via spool by 31785-submit@debbugs.gnu.org id=B31785.173480090421194 (code B ref 31785); Sat, 21 Dec 2024 17:09:02 +0000 Received: (at 31785) by debbugs.gnu.org; 21 Dec 2024 17:08:24 +0000 Received: from localhost ([127.0.0.1]:47547 helo=debbugs.gnu.org) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1tP2xj-0005Vl-Tm for submit@debbugs.gnu.org; Sat, 21 Dec 2024 12:08:24 -0500 Received: from eggs.gnu.org ([209.51.188.92]:45972) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1tP2xi-0005VX-FJ for 31785@debbugs.gnu.org; Sat, 21 Dec 2024 12:08:23 -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 1tP2xb-00040l-NO; Sat, 21 Dec 2024 12:08:15 -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:References:In-Reply-To:Subject:To: From; bh=wzRm2Mb94YE1+SeYc9ondSLuc0rChA/NAzL/CoXZPwQ=; b=CTwvlSegBHWCauY1n99g 03OxaQ/VwnwZWswn03PJgtpZgXaCR73Ows1euGUsN5HfNQDWmp818Q4mBgByUcy4TXywQg2bNlV67 wqq5bolDT81e3OkTckadA3DfmZCY8eoN/BtDKSHeEhCAm1QArzzXLgtWJogY8XzDdliFjLbY4Neqi TVpiPP+LXZGz28B9GssDCo7Y1wf3v564YFzw2y5QyXbVt7PXHQyEDFup0kpa9vyS4om0DsexlnbOA c/2nCosqcokAIA7MZ5VDD3vsVHoKARNpOtM48Yvt+0rBH2Red0yTfkHaAdDSyQG6jjkn7ratSa9ud cXXBNALxEXSJaA==; From: Ludovic =?UTF-8?Q?Court=C3=A8s?= In-Reply-To: <878qs9gg5k.fsf@gnu.org> ("Ludovic =?UTF-8?Q?Court=C3=A8s?="'s message of "Sat, 21 Dec 2024 17:22:15 +0100") References: <87602ph0yv.fsf@gnu.org> <878qs9gg5k.fsf@gnu.org> Date: Sat, 21 Dec 2024 18:08:13 +0100 Message-ID: <874j2xge0y.fsf@gnu.org> User-Agent: Gnus/5.13 (Gnus v5.13) 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: 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-Migadu-Scanner: mx11.migadu.com X-Migadu-Spam-Score: -8.42 X-Spam-Score: -8.42 X-Migadu-Queue-Id: 53F3390A7E X-TUID: +vzVnhgyEZLq (Cc=E2=80=99ing Reepca + Chris for insight! See for context.) Ludovic Court=C3=A8s skribis: > Here process 27269 holds locks on libva and rav1e and waits forever > trying to get the dav1d lock, held by 27308; process 27308 tries to get > the rav1e lock; process 27345 tries to get the libva lock. Additional data points: =E2=80=A2 All three store items are valid, yet client sessions are still = stuck with locks held and trying to acquire the other locks; =E2=80=A2 The associated timestamp of these three store items in /var/guix/db/db.sqlite is the same (one-second accuracy); =E2=80=A2 The timestamps corresponds exactly to that of the =E2=80=9Cfetc= hing path=E2=80=9D messages in the log: --8<---------------cut here---------------start------------->8--- root@hydra-guix-126 ~# grep -C3 -E "fetching.*(rav1e-0.7.1|libva-2.19.0|dav= 1d-1.5.0)'" /var/log/cuirass-remote-worker.log 2024-12-21 13:27:21 libgdata-0.18.1.tar.xz 832KiB 133.9MiB/s 00:00 ???= ????????????????? 100.0% 2024-12-21 13:27:21 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/9zbfmr41v0g4a5wm5s4y= zwn8hg8l50b0-libgdata-0.18.1.tar.xz 2024-12-21 13:27:21 fetching path `/gnu/store/zf5w9ypk8il0i9y22n81aamypr2qg= smm-dav1d-1.5.0'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/zf5w9ypk8il0i9y22n81aa= mypr2qgsmm-dav1d-1.5.0 substitute 2024-12-21 13:27:21 GmMxDR0c: substituting 14 inputs for /gnu/store/21m6i11= 0abpzdjsb2kbz2c6sm8zy3zpx-sugar-cellgame-activity-5-1.4a22fd1.drv 2024-12-21 13:27:21 Downloading http://141.80.167.131/nar/lzip/zf5w9ypk8il0= i9y22n81aamypr2qgsmm-dav1d-1.5.0... -- 2024-12-21 13:27:21 guile_gi-0.3.2.tar.gz 876KiB 124.3MiB/s 00:00 ???= ????????????????? 100.0% 2024-12-21 13:27:21 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/db700nxijpqn34a22nxp= ajbw2pwffkpv-guile_gi-0.3.2.tar.gz 2024-12-21 13:27:21 fetching path `/gnu/store/72s7500g3zg2p6fjdc1paazvm1w2x= dr2-libva-2.19.0'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/72s7500g3zg2p6fjdc1paa= zvm1w2xdr2-libva-2.19.0 substitute 2024-12-21 13:27:21 Downloading http://141.80.167.131/nar/zstd/ij5igi5xrp4s= x6c78nbvg24lb4ma2f4l-libcbor-0.11.0... 2024-12-21 13:27:21 -- 2024-12-21 13:27:21 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/ij5igi5xrp4sx6c78nbv= g24lb4ma2f4l-libcbor-0.11.0 2024-12-21 13:27:21 Downloading http://141.80.167.131/nar/zstd/72s7500g3zg2= p6fjdc1paazvm1w2xdr2-libva-2.19.0... 2024-12-21 13:27:21 fetching path `/gnu/store/0bbnhq7bagn6sbj2lmapmdiiw50v3= dgz-rav1e-0.7.1'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/0bbnhq7bagn6sbj2lmapmd= iiw50v3dgz-rav1e-0.7.1 substitute 2024-12-21 13:27:21 waiting for locks or build slots... 2024-12-21 13:27:21 --8<---------------cut here---------------end--------------->8--- It would seem that the root cause is that locks aren=E2=80=99t released even though substitution succeeded: --8<---------------cut here---------------start------------->8--- root@hydra-guix-126 ~# grep -E '(zf5w9ypk8il0i9y22n81aamypr2qgsmm|72s7500g3= zg2p6fjdc1paazvm1w2xdr2|0bbnhq7bagn6sbj2lmapmdiiw50v3dgz)' /var/log/cuirass= -remote-worker.log 2024-12-21 13:27:21 fetching path `/gnu/store/zf5w9ypk8il0i9y22n81aamypr2qg= smm-dav1d-1.5.0'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/zf5w9ypk8il0i9y22n81aa= mypr2qgsmm-dav1d-1.5.0 substitute 2024-12-21 13:27:21 Downloading http://141.80.167.131/nar/lzip/zf5w9ypk8il0= i9y22n81aamypr2qgsm -dav1d-1.5.0... 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/zf5w9ypk8il0i9y22n81= aamypr2qgsmm-dav1d-1.5.0 2024-12-21 13:27:21 fetching path `/gnu/store/72s7500g3zg2p6fjdc1paazvm1w2x= dr2-libva-2.19.0'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/72s7500g3zg2p6fjdc1paa= zvm1w2xdr2-libva-2.19.0 substitute 2024-12-21 13:27:21 Downloading http://141.80.167.131/nar/zstd/72s7500g3zg2= p6fjdc1paazvm1w2xdr -libva-2.19.0... 2024-12-21 13:27:21 fetching path `/gnu/store/0bbnhq7bagn6sbj2lmapmdiiw50v3= dgz-rav1e-0.7.1'... 2024-12-21 13:27:21 @ substituter-started /gnu/store/0bbnhq7bagn6sbj2lmapmd= iiw50v3dgz-rav1e-0.7.1 substitute 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/72s7500g3zg2p6fjdc1p= aazvm1w2xdr2-libva-2.19.0 2024-12-21 13:27:21 gst-plugins-espeak-0.5.0-1.7f6e412 19KiB 4.5MiB/s 00:= 00 ???????????????????? 100.0%Downloading http://141.80.167.131/nar/zstd/0b= bnhq7bagn6sbj2lmapmdiiw50v3dgz-rav1e-0.7.1... 2024-12-21 13:27:21 @ substituter-succeeded /gnu/store/0bbnhq7bagn6sbj2lmap= mdiiw50v3dgz-rav1e-0.7.1 --8<---------------cut here---------------end--------------->8--- Thoughts? Ludo=E2=80=99.