* 03:09:25 -- Checking if build provides SFA package... -> 03:09:25 -- + curl --silent http://build.onelab.eu/lxc//2025.09.15--f41-nofed/RPMS/x86_64/ + grep -q sfa-4 * 03:09:25 -- SFA package not found - removing steps with sfa or sfi Sensing local substrate... xp qn Done =============== Active plc VMs on buzzcocks {lxc-f41 257822.8828125 Mb} [max=20,free=15] (3 users, load: 0.86, 0.55, 0.25) == vplc01 == [=2025.09.08--f41-nofed-1-vplc01] (pid=37544) @ 2025-09-08:03-10 == vplc02 == [=2025.09.09--f41-nofed-1-vplc02] (pid=81783) @ 2025-09-09:03-10 == vplc03 == [=2025.09.10--f41-nofed-1-vplc03] (pid=135857) @ 2025-09-10:03-10 == vplc04 == [=2025.09.11--f41-nofed-1-vplc04] (pid=196909) @ 2025-09-11:03-10 == vplc05 == [=2025.09.12--f41-nofed-1-vplc05] (pid=269344) @ 2025-09-12:03-10 =============== No qemu on boxtops {qemu-f41 257822.8671875 Mb} [max=64,free=64] (2 users, load: 0.00, 0.00, 0.00) *NO kqemu/kvm_intel MODULE LOADED* Sensing IP pool for vplcs * * * * * . . . . . . . . . . . . . . . . . . . . Done After having loaded 'starting': IP pool for vplcs * * * * * . S . . . . . . . . . . . . . . . . . . * 03:09:55 -- PROVISION plc plctest1 in box buzzcocks at IP vplc06.pl.sophia.inria.fr as 2025.09.15--f41-nofed-1-vplc06 Sensing IP pool for vnodes . . . . . . . . . . . . . . . . . . . . Done After having loaded 'starting': IP pool for vnodes . S . . . . . . . . . . . . . . . . . . * 03:10:15 -- PROVISION node node1 in box boxtops at IP vnode01 with MAC 02:34:56:00:00:01 =============== Active plc VMs on buzzcocks {lxc-f41 257822.8828125 Mb} [max=20,free=13] (3 users, load: 0.86, 0.55, 0.25) == vplc01 == [=2025.09.08--f41-nofed-1-vplc01] (pid=37544) @ 2025-09-08:03-10 == vplc02 == [=2025.09.09--f41-nofed-1-vplc02] (pid=81783) @ 2025-09-09:03-10 == vplc03 == [=2025.09.10--f41-nofed-1-vplc03] (pid=135857) @ 2025-09-10:03-10 == vplc04 == [=2025.09.11--f41-nofed-1-vplc04] (pid=196909) @ 2025-09-11:03-10 == vplc05 == [=2025.09.12--f41-nofed-1-vplc05] (pid=269344) @ 2025-09-12:03-10 == dummy_vplc07.pl.sophia.inria.fr == [=dummy_vplc07.pl.sophia.inria.fr] (pid=0) @ 2025-09-15:03-09 == dummy_plctest1 == [=dummy_plctest1] (pid=0) @ 2025-09-15:03-09 =============== Qemus on boxtops {qemu-f41 257822.8671875 Mb} [max=64,free=62] (2 users, load: 0.00, 0.00, 0.00) *NO kqemu/kvm_intel MODULE LOADED* == dummy_vnode02 == [=None] not (yet?) running @ 2025-09-15:03-10 == dummy_vnode01 == [=None] not (yet?) running @ 2025-09-15:03-10 * 03:10:15 -- ********** 1 RUNNING step show on plc plctest1_vplc06 + ======== site main site for plc number 1 + nodes : vnode01.pl.sophia.inria.fr + node=node1 host_box=boxtops hostname= vnode01.pl.sophia.inria.fr ip= 138.96.112.101 * 03:10:15 -- ********** 1 SUCCESSFUL step show on plctest1_vplc06 TRACE: 1 03-10-15->0s=0:00:00.000399s status=OK step=show plc=plctest1_vplc06 force=False * 03:10:15 -- ********** 1 RUNNING step plcvm_delete on plc plctest1_vplc06 -> 03:10:15 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks mkdir -p 2025.09.15--f41-nofed Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:10:16 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2025.09.15--f41-nofed ';' rm -f /vservers/2025.09.15--f41-nofed-1-vplc06/2025.09.15--f41-nofed-1-vplc06.timestamp Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:10:16 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2025.09.15--f41-nofed ';' virsh -c lxc:/// destroy 2025.09.15--f41-nofed-1-vplc06 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. error: failed to get domain '2025.09.15--f41-nofed-1-vplc06' -> 03:10:17 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2025.09.15--f41-nofed ';' virsh -c lxc:/// undefine 2025.09.15--f41-nofed-1-vplc06 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. error: failed to get domain '2025.09.15--f41-nofed-1-vplc06' -> 03:10:17 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2025.09.15--f41-nofed ';' rm -fr /vservers/2025.09.15--f41-nofed-1-vplc06 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. * 03:10:17 -- ********** 1 SUCCESSFUL step plcvm_delete on plctest1_vplc06 TRACE: 1 03-10-15->1s=0:00:01.939668s status=OK step=plcvm_delete plc=plctest1_vplc06 force=False * 03:10:17 -- ********** 1 RUNNING step plcvm_timestamp on plc plctest1_vplc06 -> 03:10:17 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks mkdir -p /vservers/2025.09.15--f41-nofed-1-vplc06 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:10:18 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks echo 1757898617 '>' /vservers/2025.09.15--f41-nofed-1-vplc06/2025.09.15--f41-nofed-1-vplc06.timestamp Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. * 03:10:18 -- ********** 1 SUCCESSFUL step plcvm_timestamp on plctest1_vplc06 TRACE: 1 03-10-17->0s=0:00:00.732738s status=OK step=plcvm_timestamp plc=plctest1_vplc06 force=False * 03:10:18 -- ********** 1 RUNNING step plcvm_create on plc plctest1_vplc06 -> 03:10:18 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks rm -rf 2025.09.15--f41-nofed/build Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:10:18 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -r build buzzcocks:2025.09.15--f41-nofed/build -> 03:10:20 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2025.09.15--f41-nofed ';' build/lbuild-initvm.sh -p linux64 -d lxc -f f41 -r http://build.onelab.eu/lxc//2025.09.15--f41-nofed/RPMS -n vplc06.pl.sophia.inria.fr 2025.09.15--f41-nofed-1-vplc06 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. Bridge already set up - skipping create_bridge_if_needed + set -e + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift + local fcdistro=f41 + shift + local pldistro=lxc + shift + local personality=linux64 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 ++ package_method f41 ++ local fcdistro=f41 ++ shift ++ case $fcdistro in ++ echo dnf + pkg_method=dnf + case $pkg_method in + '[' -z '' ']' + fedora_install 2025.09.15--f41-nofed-1-vplc06 + set -x + set -e + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 + local cache=/var/cache/lxc/fedora/x86_64/41 + mkdir -p /var/cache/lxc/fedora/x86_64/41 + flock --exclusive --timeout 60 200 Updating cache /var/cache/lxc/fedora/x86_64/41/rootfs ... + '[' '!' -e /var/cache/lxc/fedora/x86_64/41/rootfs ']' + echo 'Updating cache /var/cache/lxc/fedora/x86_64/41/rootfs ...' + dnf --installroot /var/cache/lxc/fedora/x86_64/41/rootfs --releasever=41 -y --nogpgcheck update Updating and loading repositories: Fedora 41 - x86_64 100% | 43.0 KiB/s | 25.8 KiB | 00m01s Repositories loaded. Nothing to do. Update finished Filling /vservers/2025.09.15--f41-nofed-1-vplc06 from /var/cache/lxc/fedora/x86_64/41/rootfs ... + echo 'Update finished' + echo 'Filling /vservers/2025.09.15--f41-nofed-1-vplc06 from /var/cache/lxc/fedora/x86_64/41/rootfs ... ' + rsync -a /var/cache/lxc/fedora/x86_64/41/rootfs/ /vservers/2025.09.15--f41-nofed-1-vplc06/ + return 0 + return 0 ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 rm -rf /var/lib/rpm/__db.000 /var/lib/rpm/__db.001 /var/lib/rpm/__db.002 /var/lib/rpm/__db.003 /var/lib/rpm/__db.004 /var/lib/rpm/__db.005 /var/lib/rpm/__db.006 /var/lib/rpm/__db.007 /var/lib/rpm/__db.008 /var/lib/rpm/__db.009 ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 rpm --rebuilddb + fedora_configure 2025.09.15--f41-nofed-1-vplc06 f41 + set -x + set -e + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift + local fcdistro=f41 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 + mkdir -p /vservers/2025.09.15--f41-nofed-1-vplc06/selinux + echo 0 + cat + cat + local dev_path=/vservers/2025.09.15--f41-nofed-1-vplc06/dev + rm -rf /vservers/2025.09.15--f41-nofed-1-vplc06/dev + mkdir -p /vservers/2025.09.15--f41-nofed-1-vplc06/dev + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/null c 1 3 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/zero c 1 5 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/random c 1 8 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/urandom c 1 9 + mkdir -m 755 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/pts + mkdir -m 1777 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/shm + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty c 5 0 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty0 c 4 0 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty1 c 4 1 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty2 c 4 2 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty3 c 4 3 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/tty4 c 4 4 + mknod -m 600 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/console c 5 1 + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/full c 1 7 + mknod -m 600 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/initctl p + mknod -m 666 /vservers/2025.09.15--f41-nofed-1-vplc06/dev/ptmx c 5 2 + fedora_configure_systemd 2025.09.15--f41-nofed-1-vplc06 + set -e + set -x + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 + '[' -d /vservers/2025.09.15--f41-nofed-1-vplc06/etc/systemd ']' + ln -sf /lib/systemd/system/multi-user.target /vservers/2025.09.15--f41-nofed-1-vplc06/etc/systemd/system/default.target + touch /vservers/2025.09.15--f41-nofed-1-vplc06/etc/fstab + ln -sf /dev/null /vservers/2025.09.15--f41-nofed-1-vplc06/etc/systemd/system/udev.service + ln -sf /dev/null /vservers/2025.09.15--f41-nofed-1-vplc06/etc/systemd/system/getty@.service + rm -f /vservers/2025.09.15--f41-nofed-1-vplc06/etc/systemd/system/getty.target.wants/getty@tty1.service + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 systemctl enable NetworkManager /proc/ is not mounted. This is not a supported mode of operation. Please fix your invocation environment to mount /proc/ and /sys/ properly. Proceeding anyway. Your mileage may vary. Failed to enable unit: Unit NetworkManager.service does not exist + fedora_configure_network 2025.09.15--f41-nofed-1-vplc06 + local lxc=2025.09.15--f41-nofed-1-vplc06 + case $(network_config_method $fcdistro) in ++ network_config_method f41 ++ local fcdistro=f41 ++ shift ++ case $fcdistro in ++ echo networkmanager + local 'guest_keyfile=/vservers/2025.09.15--f41-nofed-1-vplc06/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' ++ dirname '/vservers/2025.09.15--f41-nofed-1-vplc06/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' + mkdir -p /vservers/2025.09.15--f41-nofed-1-vplc06/etc/NetworkManager/system-connections + '[' -n '' ']' + write_guest_networkmanager_publicip + cat ++ uuid ++ python -c 'import uuid; print(uuid.uuid1())' + chmod 600 '/vservers/2025.09.15--f41-nofed-1-vplc06/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' + '[' -z '' ']' + fedora_configure_yum 2025.09.15--f41-nofed-1-vplc06 f41 lxc + set -x + set -e + trap failure ERR INT + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift + local fcdistro=f41 + shift + local pldistro=lxc + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 rpm --rebuilddb Initializing yum.repos.d in 2025.09.15--f41-nofed-1-vplc06 + '[' -z '' ']' + echo 'Initializing yum.repos.d in 2025.09.15--f41-nofed-1-vplc06' + rm -f /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora-cisco-openh264.repo /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora.repo /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora.repo.rpmnew /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora-updates.repo /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora-updates.repo.rpmnew /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/fedora-updates-testing.repo + local repofile=/vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + yumconf_mirrors /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo build f41 '' http://mirror.onelab.eu/ + dest_yumconf=/vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + shift + builddir=build + shift + fcdistro=f41 + shift + yumexclude_line= + shift + mirrors=http://mirror.onelab.eu/ + template=build/mirroring/f41/yum.repos.d/building.repo.in + '[' '!' -f build/mirroring/f41/yum.repos.d/building.repo.in ']' + for mirror in $mirrors + yumconf_mirror /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo build/mirroring/f41/yum.repos.d/building.repo.in '' http://mirror.onelab.eu/ + dest_yumconf=/vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + shift + template=build/mirroring/f41/yum.repos.d/building.repo.in + shift + yumexclude_line= + shift + mirror=http://mirror.onelab.eu/ + shift + sed -e s,@MIRRORURL@,http://mirror.onelab.eu/,g -e '/baseurl=/i\ ' build/mirroring/f41/yum.repos.d/building.repo.in ++ grep '^baseurl=' /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + baseurl_defs='baseurl=http://mirror.onelab.eu//fedora/releases/41/Everything/$basearch/os/ baseurl=http://mirror.onelab.eu//fedora/updates/41/Everything/$basearch/ baseurl=http://mirror.onelab.eu//fedora/updates/41/Modular/$basearch/' + '[' -z 'baseurl=http://mirror.onelab.eu//fedora/releases/41/Everything/$basearch/os/ baseurl=http://mirror.onelab.eu//fedora/updates/41/Everything/$basearch/ baseurl=http://mirror.onelab.eu//fedora/updates/41/Modular/$basearch/' ']' + for baseurl_def in $baseurl_defs ++ echo 'baseurl=http://mirror.onelab.eu//fedora/releases/41/Everything/$basearch/os/' ++ sed -e s,baseurl=,, -e 's,$basearch,x86_64,g' + baseurl=http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os/ + repomd=http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os//repodata/repomd.xml * Trying to fetch http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os//repodata/repomd.xml + echo '* Trying to fetch http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os//repodata/repomd.xml' + build_fetch http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os//repodata/repomd.xml + curl --fail --silent --max-time 60 --output /dev/null http://mirror.onelab.eu//fedora/releases/41/Everything/x86_64/os//repodata/repomd.xml + for baseurl_def in $baseurl_defs ++ echo 'baseurl=http://mirror.onelab.eu//fedora/updates/41/Everything/$basearch/' ++ sed -e s,baseurl=,, -e 's,$basearch,x86_64,g' * Trying to fetch http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64//repodata/repomd.xml + baseurl=http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64/ + repomd=http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64//repodata/repomd.xml + echo '* Trying to fetch http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64//repodata/repomd.xml' + build_fetch http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64//repodata/repomd.xml + curl --fail --silent --max-time 60 --output /dev/null http://mirror.onelab.eu//fedora/updates/41/Everything/x86_64//repodata/repomd.xml + for baseurl_def in $baseurl_defs ++ echo 'baseurl=http://mirror.onelab.eu//fedora/updates/41/Modular/$basearch/' ++ sed -e s,baseurl=,, -e 's,$basearch,x86_64,g' + baseurl=http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64/ + repomd=http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64//repodata/repomd.xml * Trying to fetch http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64//repodata/repomd.xml + echo '* Trying to fetch http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64//repodata/repomd.xml' + build_fetch http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64//repodata/repomd.xml + curl --fail --silent --max-time 60 --output /dev/null http://mirror.onelab.eu//fedora/updates/41/Modular/x86_64//repodata/repomd.xml * Selected mirror http://mirror.onelab.eu/ + echo '* Selected mirror http://mirror.onelab.eu/' + return 0 + return 0 + sed -i /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo -e 's,gpgkey=.*,gpgkey=http://mirror.onelab.eu/keys//RPM-GPG-KEY-fedora-41-primary,' + rpm --root /vservers/2025.09.15--f41-nofed-1-vplc06 --import http://mirror.onelab.eu/keys//RPM-GPG-KEY-fedora-41-primary + '[' -n http://build.onelab.eu/lxc//2025.09.15--f41-nofed/RPMS ']' + '[' '!' -d /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d ']' ++ pl_plcyumexclude f41 lxc build ++ pl_yumexclude plcyumexclude f41 lxc build ++ keyword=plcyumexclude ++ shift ++ fcdistro=f41 ++ shift ++ pldistro=lxc ++ shift ++ builddir=build ++ shift +++ pl_locateDistroFile build lxc yumexclude.pkgs +++ builddir=build +++ shift +++ pldistro=lxc +++ shift +++ pkgsfile=yumexclude.pkgs +++ shift +++ pkgspath= +++ configdir=build/config.lxc +++ '[' '!' -d build/config.lxc ']' +++ paths='build/config.lxc/yumexclude.pkgs build/config.planetlab/yumexclude.pkgs' +++ for path in $paths +++ '[' -f build/config.lxc/yumexclude.pkgs ']' +++ pkgspath=build/config.lxc/yumexclude.pkgs +++ break +++ '[' -z build/config.lxc/yumexclude.pkgs ']' +++ echo 'pl_locateDistroFile: using build/config.lxc/yumexclude.pkgs' pl_locateDistroFile: using build/config.lxc/yumexclude.pkgs +++ echo build/config.lxc/yumexclude.pkgs +++ return 0 ++ yumexclude_file=build/config.lxc/yumexclude.pkgs ++ type -p pkgs.py ++ pkgs.py -a x86_64 -f f41 -d lxc plcyumexclude build/config.lxc/yumexclude.pkgs + yumexclude=drupal + for repo in $lxc_root/etc/yum.repos.d/* + '[' -f /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo ']' + yumconf_exclude /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo exclude=drupal + repo=/vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + shift + yumexclude_line=exclude=drupal + shift + sed -i -e '/#baseurl=.*$/i\ exclude=drupal' /vservers/2025.09.15--f41-nofed-1-vplc06/etc/yum.repos.d/building.repo + cat + return 0 + '[' -d /vservers/2025.09.15--f41-nofed-1-vplc06/cgroup ']' + mkdir /vservers/2025.09.15--f41-nofed-1-vplc06/cgroup + '[' -h /vservers/2025.09.15--f41-nofed-1-vplc06/etc/resolv.conf ']' + rm -f /vservers/2025.09.15--f41-nofed-1-vplc06/etc/resolv.conf + '[' -f /etc/resolv.conf.containers ']' + cp /etc/resolv.conf.containers /vservers/2025.09.15--f41-nofed-1-vplc06/etc/resolv.conf + '[' -f /vservers/2025.09.15--f41-nofed-1-vplc06/etc/hosts ']' + mkdir -p /vservers/2025.09.15--f41-nofed-1-vplc06/root/.ssh + cat /root/.ssh/id_rsa.pub + chmod 700 /vservers/2025.09.15--f41-nofed-1-vplc06/root/.ssh + chmod 600 /vservers/2025.09.15--f41-nofed-1-vplc06/root/.ssh/authorized_keys + local config_xml=/tmp/2025.09.15--f41-nofed-1-vplc06.xml + '[' -n '' ']' + write_lxc_xml_publicip 2025.09.15--f41-nofed-1-vplc06 + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 + cat + virsh -c lxc:/// define /tmp/2025.09.15--f41-nofed-1-vplc06.xml Domain '2025.09.15--f41-nofed-1-vplc06' defined from /tmp/2025.09.15--f41-nofed-1-vplc06.xml + return 0 + devel_or_test_tools 2025.09.15--f41-nofed-1-vplc06 f41 lxc linux64 + set -x + set -e + trap failure ERR INT + local lxc=2025.09.15--f41-nofed-1-vplc06 + shift + local fcdistro=f41 + shift + local pldistro=lxc + shift + local personality=linux64 + shift ++ lxcroot 2025.09.15--f41-nofed-1-vplc06 ++ local lxc=2025.09.15--f41-nofed-1-vplc06 ++ shift ++ echo /vservers/2025.09.15--f41-nofed-1-vplc06 + local lxc_root=/vservers/2025.09.15--f41-nofed-1-vplc06 ++ package_method f41 ++ local fcdistro=f41 ++ shift ++ case $fcdistro in ++ echo dnf + local pkg_method=dnf ++ pl_locateDistroFile build lxc runtime.pkgs ++ builddir=build ++ shift ++ pldistro=lxc ++ shift ++ pkgsfile=runtime.pkgs ++ shift ++ pkgspath= ++ configdir=build/config.lxc ++ '[' '!' -d build/config.lxc ']' ++ paths='build/config.lxc/runtime.pkgs build/config.planetlab/runtime.pkgs' ++ for path in $paths ++ '[' -f build/config.lxc/runtime.pkgs ']' ++ for path in $paths ++ '[' -f build/config.planetlab/runtime.pkgs ']' ++ pkgspath=build/config.planetlab/runtime.pkgs ++ break ++ '[' -z build/config.planetlab/runtime.pkgs ']' ++ echo 'pl_locateDistroFile: using build/config.planetlab/runtime.pkgs' pl_locateDistroFile: using build/config.planetlab/runtime.pkgs ++ echo build/config.planetlab/runtime.pkgs ++ return 0 + local pkgsfile=build/config.planetlab/runtime.pkgs ++ chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 arch + local lxc_arch=x86_64 + '[' x86_64 = unknown ']' ++ pl_getPackages -a x86_64 f41 lxc build/config.planetlab/runtime.pkgs ++ pl_parsePkgs package -a x86_64 f41 lxc build/config.planetlab/runtime.pkgs ++ target_arch=x86_64 ++ keyword=package ++ shift ++ '[' -a == -a ']' ++ shift ++ target_arch=x86_64 ++ shift ++ fcdistro=f41 ++ shift ++ pldistro=lxc ++ shift ++ echo 'pl_parsePkgs: using -a x86_64 -f f41 -d lxc package build/config.planetlab/runtime.pkgs' pl_parsePkgs: using -a x86_64 -f f41 -d lxc package build/config.planetlab/runtime.pkgs ++ pkgs.py -a x86_64 -f f41 -d lxc package build/config.planetlab/runtime.pkgs build/config.planetlab/runtime.pkgs:9:syntax error: error in left expression package=jammy build/config.planetlab/runtime.pkgs:10:syntax error: error in left expression package=noble + local 'packages=NetworkManager bind-utils curl emacs-nox file hostname openssh-clients psmisc' ++ pl_getGroups -a x86_64 f41 lxc build/config.planetlab/runtime.pkgs ++ pl_parsePkgs group -a x86_64 f41 lxc build/config.planetlab/runtime.pkgs ++ target_arch=x86_64 ++ keyword=group ++ shift ++ '[' -a == -a ']' ++ shift ++ target_arch=x86_64 ++ shift ++ fcdistro=f41 ++ shift ++ pldistro=lxc ++ shift ++ echo 'pl_parsePkgs: using -a x86_64 -f f41 -d lxc group build/config.planetlab/runtime.pkgs' pl_parsePkgs: using -a x86_64 -f f41 -d lxc group build/config.planetlab/runtime.pkgs ++ pkgs.py -a x86_64 -f f41 -d lxc group build/config.planetlab/runtime.pkgs build/config.planetlab/runtime.pkgs:9:syntax error: error in left expression package=jammy build/config.planetlab/runtime.pkgs:10:syntax error: error in left expression package=noble + local groups= + case "$pkg_method" in + local has_dnf= + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 dnf --version Failed to set locale, defaulting to "C.UTF-8" dnf5 version 5.2.16.0 dnf5 plugin API version 2.0 libdnf5 version 5.2.16.0 libdnf5 plugin API version 2.2 container has dnf - invoking with --allowerasing + has_dnf=true + '[' -n true ']' + echo 'container has dnf - invoking with --allowerasing' + local 'pkg_installer=dnf -y install --allowerasing' + local 'grp_installer=dnf -y groupinstall --allowerasing' + '[' -n 'NetworkManager bind-utils curl emacs-nox file hostname openssh-clients psmisc' ']' + chroot /vservers/2025.09.15--f41-nofed-1-vplc06 linux64 dnf -y install --allowerasing NetworkManager bind-utils curl emacs-nox file hostname openssh-clients psmisc Failed to set locale, defaulting to "C.UTF-8" Updating and loading repositories: Fedora 41 - x86_64 - Updates 100% | 11.9 MiB/s | 549.7 KiB | 00m00s >>> Status code: 404 for http://mirror.onelab.eu//fedora/updates/41/Everything/x >>> Status code: 404 for http://mirror.onelab.eu//fedora/updates/41/Everything/x >>> Status code: 404 for http://mirror.onelab.eu//fedora/updates/41/Everything/x >>> Status code: 404 for http://mirror.onelab.eu//fedora/updates/41/Everything/x >>> Status code: 404 for http://mirror.onelab.eu//fedora/updates/41/Everything/x MyPLC 100% | 28.4 KiB/s | 11.4 KiB | 00m00s Fedora 41 - x86_64 - Updates 100% | 4.1 KiB/s | 1.6 KiB | 00m00s Fedora 41 - x86_64 100% | 829.4 KiB/s | 449.5 KiB | 00m01s Failed to load repository: "primary" data not present or in unsupported format lbuild-initvm.sh : Bailing out ++ failure ++ echo 'lbuild-initvm.sh : Bailing out' ++ exit 1 * 03:10:26 -- ********** 1 FAILED step plcvm_create on plctest1_vplc06 (discarded from further steps) TRACE: 1 03-10-18->7s=0:00:07.849245s status=KO step=plcvm_create plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step django_install on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000156s status=UNDEF step=django_install plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step plc_install on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000095s status=UNDEF step=plc_install plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step plc_configure on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000080s status=UNDEF step=plc_configure plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step plc_start on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000077s status=UNDEF step=plc_start plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step keys_fetch on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000075s status=UNDEF step=keys_fetch plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step keys_store on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000073s status=UNDEF step=keys_store plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step keys_clear_known_hosts on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000080s status=UNDEF step=keys_clear_known_hosts plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step plcapi_urls on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000074s status=UNDEF step=plcapi_urls plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step speed_up_slices on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000074s status=UNDEF step=speed_up_slices plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step initscripts on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000073s status=UNDEF step=initscripts plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step sites on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000074s status=UNDEF step=sites plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step nodes on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000073s status=UNDEF step=nodes plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step slices on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000107s status=UNDEF step=slices plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step nodegroups on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000077s status=UNDEF step=nodegroups plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 SKIPPED Step leases on plctest1_vplc06 (has failed plcvm_create) TRACE: 1 03-10-26->0s=0:00:00.000074s status=UNDEF step=leases plc=plctest1_vplc06 force=False * 03:10:26 -- ********** 1 RUNNING step gather_logs (forced after plcvm_create has failed) on plc plctest1_vplc06 -------------------- TestPlc.gather_logs : PLC's /var/log -> 03:10:26 -- + mkdir -p logs/myplc.var-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -> 03:10:26 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc06 tar -C /var/log/ -cf - . + tar -C logs/myplc.var-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -xf - Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc06 port 22: No route to host tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -> 03:10:29 -- + chmod a+r,a+x logs/myplc.var-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06/httpd chmod: cannot access 'logs/myplc.var-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06/httpd': No such file or directory -------------------- TestPlc.gather_logs : PLC's /var/lib/psql/data/pg_log/ -> 03:10:29 -- + mkdir -p logs/myplc.pgsql-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -> 03:10:29 -- + tar -C logs/myplc.pgsql-log.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -xf - + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc06 tar -C /var/lib/pgsql/data/pg_log/ -cf - . Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc06 port 22: No route to host tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -------------------- TestPlc.gather_logs : PLC's /root/sfi/ -> 03:10:33 -- + mkdir -p logs/sfi.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -> 03:10:33 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc06 tar -C /root/sfi/ -cf - . + tar -C logs/sfi.plctest1_vplc06.2025.09.15--f41-nofed-1-vplc06 -xf - Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc06 port 22: No route to host tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -------------------- TestPlc.gather_logs : nodes's QEMU logs -> 03:10:36 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 boxtops:/vservers/2025.09.15--f41-nofed/qemu-vnode01.pl.sophia.inria.fr/log.txt logs/node.qemu.vnode01.pl.sophia.inria.fr.txt scp: /vservers/2025.09.15--f41-nofed/qemu-vnode01.pl.sophia.inria.fr/log.txt: No such file or directory -------------------- TestPlc.gather_logs : nodes's /var/log -> 03:10:37 -- + mkdir -p logs/node.var-log.vnode01.pl.sophia.inria.fr -> 03:10:37 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null -i keys/key_admin.rsa vnode01.pl.sophia.inria.fr tar -C /var/log -cf - . + tar -C logs/node.var-log.vnode01.pl.sophia.inria.fr -xf - Warning: Identity file keys/key_admin.rsa not accessible: No such file or directory. ssh: connect to host vnode01.pl.sophia.inria.fr port 22: No route to host tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -------------------- TestPlc.gather_logs : sample sliver's /var/log Traceback (most recent call last): File "/root/2025.09.15--f41-nofed/TestMain.py", line 511, in run step_result = method(plc_obj) File "/root/2025.09.15--f41-nofed/TestPlc.py", line 1929, in gather_logs self.gather_slivers_var_logs() ~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^ File "/root/2025.09.15--f41-nofed/TestPlc.py", line 1933, in gather_slivers_var_logs for test_sliver in self.all_sliver_objs(): ~~~~~~~~~~~~~~~~~~~~^^ File "/root/2025.09.15--f41-nofed/TestPlc.py", line 427, in all_sliver_objs result.append(self.locate_sliver_obj(nodename, slicename)) ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^ File "/root/2025.09.15--f41-nofed/TestPlc.py", line 438, in locate_sliver_obj return TestSliver(self, test_node, test_slice) File "/root/2025.09.15--f41-nofed/TestSliver.py", line 16, in __init__ self.test_ssh = self.create_test_ssh() ~~~~~~~~~~~~~~~~~~~~^^ File "/root/2025.09.15--f41-nofed/TestSliver.py", line 29, in create_test_ssh raise Exception("Cannot find the private key for slice {}".format(self.test_slice.name())) Exception: Cannot find the private key for slice inri_sl1 * 03:10:40 -- ********** 1 FAILED (exception) step gather_logs on plctest1_vplc06 (discarded from further steps) TRACE: 1 03-10-26->14s=0:00:14.344819s status=KO step=gather_logs plc=plctest1_vplc06 force=True TestMain exit code 1