Ludovic Courtès <ludo@HIDDEN>
to control <at> debbugs.gnu.org.
Full text available.
Received: (at submit) by debbugs.gnu.org; 7 May 2021 19:45:29 +0000
From debbugs-submit-bounces <at> debbugs.gnu.org Fri May 07 15:45:29 2021
Received: from localhost ([127.0.0.1]:45623 helo=debbugs.gnu.org)
by debbugs.gnu.org with esmtp (Exim 4.84_2)
(envelope-from <debbugs-submit-bounces <at> debbugs.gnu.org>)
id 1lf6Pg-0002UX-Kc
for submit <at> debbugs.gnu.org; Fri, 07 May 2021 15:45:29 -0400
Received: from lists.gnu.org ([209.51.188.17]:42958)
by debbugs.gnu.org with esmtp (Exim 4.84_2)
(envelope-from <ludovic.courtes@HIDDEN>) id 1lf6Pe-0002UP-CC
for submit <at> debbugs.gnu.org; Fri, 07 May 2021 15:45:27 -0400
Received: from eggs.gnu.org ([2001:470:142:3::10]:45202)
by lists.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256)
(Exim 4.90_1) (envelope-from <ludovic.courtes@HIDDEN>)
id 1lf6Pe-0004Zq-1J
for bug-guix@HIDDEN; Fri, 07 May 2021 15:45:26 -0400
Received: from mail3-relais-sop.national.inria.fr ([192.134.164.104]:10193)
by eggs.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256)
(Exim 4.90_1) (envelope-from <ludovic.courtes@HIDDEN>)
id 1lf6Pb-0004Lp-5K
for bug-guix@HIDDEN; Fri, 07 May 2021 15:45:25 -0400
IronPort-HdrOrdr: =?us-ascii?q?A9a23=3AF10Wz6BXyfiKYUnlHemK55DYdb4zR+YMi2TD?=
=?us-ascii?q?tnoRdfUxSKClfq+V/MjzuSWE6wr5OktQ/exoSZPwI080nKQdieN9UtmfsRHdyR?=
=?us-ascii?q?GVxepZnOzfKlPbakjD398Y+aB8c7VvTP3cZGIK9frS0U2XNPtl+sSO7byz7N2u?=
=?us-ascii?q?tEuFGjsAV0i41XYeNu9MKDwOeDV7?=
X-IronPort-AV: E=Sophos;i="5.82,282,1613430000"; d="scan'208";a="380857113"
Received: from 91-160-117-201.subs.proxad.net (HELO ribbon) ([91.160.117.201])
by mail3-relais-sop.national.inria.fr with
ESMTP/TLS/DHE-RSA-AES256-GCM-SHA384; 07 May 2021 21:45:16 +0200
From: =?utf-8?Q?Ludovic_Court=C3=A8s?= <ludovic.courtes@HIDDEN>
To: <bug-guix@HIDDEN>
Subject: Daemon enters substitute query loop when only one of several
outputs is substitutable
X-Debbugs-Cc: Ricardo Wurmus <rekado@HIDDEN>, zimoun
<zimon.toutoune@HIDDEN>
X-URL: http://www.fdn.fr/~lcourtes/
X-Revolutionary-Date: 18 =?utf-8?Q?Flor=C3=A9al?= an 229 de la =?utf-8?Q?R?=
=?utf-8?Q?=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, 07 May 2021 21:45:15 +0200
Message-ID: <878s4qba5w.fsf@HIDDEN>
User-Agent: Gnus/5.13 (Gnus v5.13) Emacs/27.2 (gnu/linux)
MIME-Version: 1.0
Content-Type: text/plain; charset=utf-8
Content-Transfer-Encoding: quoted-printable
Received-SPF: pass client-ip=192.134.164.104;
envelope-from=ludovic.courtes@HIDDEN;
helo=mail3-relais-sop.national.inria.fr
X-Spam_score_int: -41
X-Spam_score: -4.2
X-Spam_bar: ----
X-Spam_report: (-4.2 / 5.0 requ) BAYES_00=-1.9, RCVD_IN_DNSWL_MED=-2.3,
RCVD_IN_MSPIKE_H3=0.001, RCVD_IN_MSPIKE_WL=0.001, SPF_HELO_NONE=0.001,
SPF_PASS=-0.001 autolearn=ham autolearn_force=no
X-Spam_action: no action
X-Spam-Score: -1.3 (-)
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.3 (--)
Hi!
=E2=80=98guix build /gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-0=
.11.3.drv=E2=80=99 (it=E2=80=99s a derivation from
d57660c54907cc6fba8b0adf6295fd2311ada6cf, Oct. 2019) currently enters an
endless substitute query loop (with ci.guix.gnu.org substitutes enabled,
where ci.guix.gnu.org currently lacks this substitute):
--8<---------------cut here---------------start------------->8---
$ guix describe
Generacio 182 May 04 2021 08:56:26 (nuna)
guix fcd002c
repository URL: https://git.savannah.gnu.org/git/guix.git
branch: master
commit: fcd002ccfa3a2bf28a9d05ab2992464afc6e5fca
$ guix build /gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-0.11.3.d=
rv --debug=3D3
La jena derivo estos konstruata:
/gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-0.11.3.drv
[at this point, loops=E2=80=A6]
--8<---------------cut here---------------end--------------->8---
Looking at the corresponding =E2=80=98guix substitute --query=E2=80=99 proc=
ess shows
this:
--8<---------------cut here---------------start------------->8---
read(0, "info /gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3 =
\n", 4096) =3D 67
openat(AT_FDCWD, "/var/guix/substitute/cache/4refhwxbjmeua2kwg2nmzhv4dg4d3d=
orpjefq7kiciw2pfhaf26a/q89w5vk8lyw4jw9knd104qk3381b03dw", O_RDONLY) =3D 14
fstat(14, {st_mode=3DS_IFREG|0600, st_size=3D99, ...}) =3D 0
lseek(14, 0, SEEK_CUR) =3D 0
read(14, "(narinfo (version 2) (cache-uri \"https://ci.guix.gnu.org\") (dat=
e 1620414701) (ttl 3600) (value #f))", 4096) =3D 99
close(14) =3D 0
write(4, "\n", 1) =3D 1
read(0, "info /gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3 =
\n", 4096) =3D 67
openat(AT_FDCWD, "/var/guix/substitute/cache/4refhwxbjmeua2kwg2nmzhv4dg4d3d=
orpjefq7kiciw2pfhaf26a/q89w5vk8lyw4jw9knd104qk3381b03dw", O_RDONLY) =3D 14
fstat(14, {st_mode=3DS_IFREG|0600, st_size=3D99, ...}) =3D 0
lseek(14, 0, SEEK_CUR) =3D 0
read(14, "(narinfo (version 2) (cache-uri \"https://ci.guix.gnu.org\") (dat=
e 1620414701) (ttl 3600) (value #f))", 4096) =3D 99
close(14) =3D 0
write(4, "\n", 1) =3D 1
read(0, "info /gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-ssh-0.11.3-=
debug \n", 4096) =3D 73
openat(AT_FDCWD, "/var/guix/substitute/cache/4refhwxbjmeua2kwg2nmzhv4dg4d3d=
orpjefq7kiciw2pfhaf26a/2lfh3rblh0a38s36q7xyhkac6l5kknw3", O_RDONLY) =3D 14
fstat(14, {st_mode=3DS_IFREG|0600, st_size=3D1421, ...}) =3D 0
lseek(14, 0, SEEK_CUR) =3D 0
read(14, "(narinfo (version 2) (cache-uri \"https://ci.guix.gnu.org\") (dat=
e 1620414701) (ttl 7776000) (value \"StorePath: /gnu/store/2lfh3rblh0a38s36=
q7xyhkac6l5kknw3-guile-ssh-0.11.3-debug\\nURL: nar/gzip/2lfh3rblh0a38s36q7x=
yhkac6l5kknw3-guile-ssh-0.11.3-debug\\nCompression: gzip\\nFileSize: 347198=
\\nURL: nar/lzip/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-ssh-0.11.3-debug\\n=
Compression: lzip\\nFileSize: 220285\\nNarHash: sha256:0xybb41pvgxyi4fcrgml=
2qd68wh3gwv78h4r81n54w6h2dskrf08\\nNarSize: 2360032\\nReferences: 4sqps8"..=
., 4096) =3D 1421
close(14) =3D 0
write(4, "/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-ssh-0.11.3-debu=
g\n", 67) =3D 67
write(4, "/gnu/store/9slm8shib43rjz1pykww0pikhb9rnfz9-guile-ssh-0.11.3.drv\=
n", 65) =3D 65
write(4, "5\n", 2) =3D 2
write(4, "/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.5.0-lib\n", 58)=
=3D 58
write(4, "/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-2.2.4\n", 56) =
=3D 56
write(4, "/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-2.28\n", 55) =
=3D 55
write(4, "/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh-0.9.0\n", 57) =
=3D 57
write(4, "/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3\n", =
61) =3D 61
write(4, "220285\n", 7) =3D 7
write(4, "2360032\n", 8) =3D 8
write(4, "\n", 1) =3D 1
read(0, "info /gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3 =
\n", 4096) =3D 67
openat(AT_FDCWD, "/var/guix/substitute/cache/4refhwxbjmeua2kwg2nmzhv4dg4d3d=
orpjefq7kiciw2pfhaf26a/q89w5vk8lyw4jw9knd104qk3381b03dw", O_RDONLY) =3D 14
fstat(14, {st_mode=3DS_IFREG|0600, st_size=3D99, ...}) =3D 0
lseek(14, 0, SEEK_CUR) =3D 0
read(14, "(narinfo (version 2) (cache-uri \"https://ci.guix.gnu.org\") (dat=
e 1620414701) (ttl 3600) (value #f))", 4096) =3D 99
close(14) =3D 0
write(4, "\n", 1) =3D 1
--8<---------------cut here---------------end--------------->8---
The =E2=80=9Cdebug=E2=80=9D output substitute is available, but not =E2=80=
=9Cout=E2=80=9D, and the
daemon keeps asking alternatively for =E2=80=9Cout=E2=80=9D (twice) and =E2=
=80=9Cdebug=E2=80=9D (once)
in a loop.
At that point, =E2=80=98guix build=E2=80=99 is stuck waiting for the reply =
to its
=E2=80=98build-derivations=E2=80=99 RPC, so the problem appears to be in th=
e daemon.
Running =E2=80=98guix build --debug=3D4 =E2=80=A6=E2=80=99 shows this:
--8<---------------cut here---------------start------------->8---
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': created
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': woken up
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': created
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': woken up
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': trying substituter
| | path `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3'=
is required, but there is no substituter that can build it
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': done
| | building of `/gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-=
0.11.3.drv': waitee `substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk338=
1b03dw-guile-ssh-0.11.3'' done; 1 left
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': trying substituter
| | substitution of `/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.=
5.0-lib': created
| | substitution of `/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.=
5.0-lib': woken up
| | substitution of `/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-=
2.2.4': created
| | substitution of `/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-=
2.2.4': woken up
| | substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-=
2.28': created
| | substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-=
2.28': woken up
| | substitution of `/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh=
-0.9.0': created
| | substitution of `/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh=
-0.9.0': woken up
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': created
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': woken up
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': goal destroyed
| | substitution of `/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.=
5.0-lib': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.=
5.0-lib': done
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': waitee `substitution of `/gnu/store/4sqps8dczv3g7rwbdibf=
z6rf5jlk7w90-gcc-5.5.0-lib'' done; 4 left
| | substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-=
2.28': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-=
2.28': done
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': waitee `substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dg=
xsdrigddfmq4-glibc-2.28'' done; 3 left
| | substitution of `/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-=
2.2.4': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-=
2.2.4': done
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': waitee `substitution of `/gnu/store/9alic3caqhay3h8mx4ii=
hpmyj6ymqpcx-guile-2.2.4'' done; 2 left
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': trying substituter
| | path `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-ssh-0.11.3'=
is required, but there is no substituter that can build it
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': done
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': waitee `substitution of `/gnu/store/q89w5vk8lyw4jw9knd10=
4qk3381b03dw-guile-ssh-0.11.3'' done; 1 left
| | substitution of `/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh=
-0.9.0': init
| | acquiring write lock on `/var/guix/temproots/18129'
| | downgrading to read lock on `/var/guix/temproots/18129'
| | substitution of `/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh=
-0.9.0': done
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': waitee `substitution of `/gnu/store/ljig01r4nazpjijhvmvr=
fwhv03ypc9a6-libssh-0.9.0'' done; 0 left
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': woken up
| | substitution of `/gnu/store/ljig01r4nazpjijhvmvrfwhv03ypc9a6-libssh=
-0.9.0': goal destroyed
| | substitution of `/gnu/store/q89w5vk8lyw4jw9knd104qk3381b03dw-guile-=
ssh-0.11.3': goal destroyed
| | substitution of `/gnu/store/9alic3caqhay3h8mx4iihpmyj6ymqpcx-guile-=
2.2.4': goal destroyed
| | substitution of `/gnu/store/h90vnqw0nwd0hhm1l5dgxsdrigddfmq4-glibc-=
2.28': goal destroyed
| | substitution of `/gnu/store/4sqps8dczv3g7rwbdibfz6rf5jlk7w90-gcc-5.=
5.0-lib': goal destroyed
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': all references realised
| | some references of path `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw=
3-guile-ssh-0.11.3-debug' could not be realised
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': done
| | building of `/gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-=
0.11.3.drv': waitee `substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l=
5kknw3-guile-ssh-0.11.3-debug'' done; 0 left
| | building of `/gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-=
0.11.3.drv': woken up
| | substitution of `/gnu/store/2lfh3rblh0a38s36q7xyhkac6l5kknw3-guile-=
ssh-0.11.3-debug': goal destroyed
| | building of `/gnu/store/1k8lgjs4al3gp3hri73wrbslbqa16hac-guile-ssh-=
0.11.3.drv': all outputs substituted (maybe)
--8<---------------cut here---------------end--------------->8---
Note =E2=80=9Cthere is not substituter that can build it=E2=80=9D (for =E2=
=80=9Cout=E2=80=9D), as well
as the last line.
Nix commit 4ac4f675df3da01b6d814cd328dd3219dd472ac9 (from 2018) touches
code in this area. To be continued=E2=80=A6
Ludo=E2=80=99.
Ludovic Courtès <ludovic.courtes@HIDDEN>:rekado@HIDDEN, zimon.toutoune@HIDDEN, bug-guix@HIDDEN.
Full text available.rekado@HIDDEN, zimon.toutoune@HIDDEN, bug-guix@HIDDEN:bug#48279; Package guix.
Full text available.
GNU bug tracking system
Copyright (C) 1999 Darren O. Benham,
1997 nCipher Corporation Ltd,
1994-97 Ian Jackson.