/root/2024.07.02--f39-nofed/TestPlc.py:1622: SyntaxWarning: invalid escape sequence '\*' utils.output_of(self.actual_command_in_guest('find /var/cache/yum -name sfa-client\*.rpm')) /root/2024.07.02--f39-nofed/Substrate.py:462: SyntaxWarning: invalid escape sequence '\s' build_matcher=re.compile("\s*(?P[0-9]+).*-[bo]\s+(?P[^\s]+)(\s|\Z)") /root/2024.07.02--f39-nofed/Substrate.py:463: SyntaxWarning: invalid escape sequence '\s' build_matcher_initvm=re.compile("\s*(?P[0-9]+).*initvm.*\s+(?P[^\s]+)\s*\Z") /root/2024.07.02--f39-nofed/Substrate.py:746: SyntaxWarning: invalid escape sequence '\s' matcher=re.compile("\s*(?P[0-9]+).*-cdrom\s+(?P[^\s]+)\.iso") /root/2024.07.02--f39-nofed/Substrate.py:931: SyntaxWarning: invalid escape sequence '\s' matcher_grep=re.compile ("/root/(?P[^/]+)/logs/trace.*:TRACE:\s*(?P[0-9]+).*step=(?P\S+).*") * 03:12:44 -- Checking if build provides SFA package... -> 03:12:44 -- + curl --silent http://build.onelab.eu/lxc//2024.07.02--f39-nofed/RPMS/x86_64/ + grep -q sfa-4 * 03:12:44 -- SFA package not found - removing steps with sfa or sfi Sensing local substrate... xp qn Done =============== Active plc VMs on buzzcocks {lxc-f39 257831.00390625 Mb} [max=20,free=7] (0 user, load: 3.02, 1.50, 0.75) == vplc01 == [=2024.06.19--f39-nofed-1-vplc01] (pid=28227) @ 2024-06-19:03-10 == vplc02 == [=2024.06.20--f39-nofed-1-vplc02] (pid=73417) @ 2024-06-20:03-10 == vplc03 == [=2024.06.21--f39-nofed-1-vplc03] (pid=129603) @ 2024-06-21:03-10 == vplc04 == [=2024.06.22--f39-nofed-1-vplc04] (pid=187670) @ 2024-06-22:03-10 == vplc05 == [=2024.06.23--f39-nofed-1-vplc05] (pid=259222) @ 2024-06-23:03-10 == vplc06 == [=2024.06.24--f39-nofed-1-vplc06] (pid=338423) @ 2024-06-24:03-10 == vplc07 == [=2024.06.25--f39-nofed-1-vplc07] (pid=424362) @ 2024-06-25:03-10 == vplc08 == [=2024.06.26--f39-nofed-1-vplc08] (pid=516991) @ 2024-06-26:03-10 == vplc09 == [=2024.06.27--f39-nofed-1-vplc09] (pid=624056) @ 2024-06-27:03-10 == vplc10 == [=2024.06.28--f39-nofed-1-vplc10] (pid=735253) @ 2024-06-28:03-10 == vplc11 == [=2024.06.29--f39-nofed-1-vplc11] (pid=857492) @ 2024-06-29:03-10 == vplc12 == [=2024.06.30--f39-nofed-1-vplc12] (pid=988398) @ 2024-06-30:03-10 == vplc13 == [=2024.07.01--f39-nofed-1-vplc13] (pid=1131505) @ 2024-07-01:03-10 =============== No qemu on boxtops {qemu-f39 257830.9921875 Mb} [max=64,free=64] (0 user, load: 0.06, 0.02, 0.00) kvm_intel OK Sensing IP pool for vplcs * * * * * * * * * * * * * . . . . . . . . . . . . Done After having loaded 'starting': IP pool for vplcs * * * * * * * * * * * * * . . . . . . . . . . . . * 03:13:18 -- PROVISION plc plctest1 in box buzzcocks at IP vplc14.pl.sophia.inria.fr as 2024.07.02--f39-nofed-1-vplc14 Sensing IP pool for vnodes . . . . . . . . . . . . . . . . . . . . Done After having loaded 'starting': IP pool for vnodes . . . . . . . . . . . . . . . . . . . . * 03:13:38 -- PROVISION node node1 in box boxtops at IP vnode01 with MAC 02:34:56:00:00:01 =============== Active plc VMs on buzzcocks {lxc-f39 257831.00390625 Mb} [max=20,free=6] (0 user, load: 3.02, 1.50, 0.75) == vplc01 == [=2024.06.19--f39-nofed-1-vplc01] (pid=28227) @ 2024-06-19:03-10 == vplc02 == [=2024.06.20--f39-nofed-1-vplc02] (pid=73417) @ 2024-06-20:03-10 == vplc03 == [=2024.06.21--f39-nofed-1-vplc03] (pid=129603) @ 2024-06-21:03-10 == vplc04 == [=2024.06.22--f39-nofed-1-vplc04] (pid=187670) @ 2024-06-22:03-10 == vplc05 == [=2024.06.23--f39-nofed-1-vplc05] (pid=259222) @ 2024-06-23:03-10 == vplc06 == [=2024.06.24--f39-nofed-1-vplc06] (pid=338423) @ 2024-06-24:03-10 == vplc07 == [=2024.06.25--f39-nofed-1-vplc07] (pid=424362) @ 2024-06-25:03-10 == vplc08 == [=2024.06.26--f39-nofed-1-vplc08] (pid=516991) @ 2024-06-26:03-10 == vplc09 == [=2024.06.27--f39-nofed-1-vplc09] (pid=624056) @ 2024-06-27:03-10 == vplc10 == [=2024.06.28--f39-nofed-1-vplc10] (pid=735253) @ 2024-06-28:03-10 == vplc11 == [=2024.06.29--f39-nofed-1-vplc11] (pid=857492) @ 2024-06-29:03-10 == vplc12 == [=2024.06.30--f39-nofed-1-vplc12] (pid=988398) @ 2024-06-30:03-10 == vplc13 == [=2024.07.01--f39-nofed-1-vplc13] (pid=1131505) @ 2024-07-01:03-10 == dummy_plctest1 == [=dummy_plctest1] (pid=0) @ 2024-07-02:03-13 =============== Qemus on boxtops {qemu-f39 257830.9921875 Mb} [max=64,free=63] (0 user, load: 0.06, 0.02, 0.00) kvm_intel OK == dummy_vnode01 == [=None] not (yet?) running @ 2024-07-02:03-13 * 03:13:38 -- ********** 1 RUNNING step show on plc plctest1_vplc14 + ======== 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:13:38 -- ********** 1 SUCCESSFUL step show on plctest1_vplc14 TRACE: 1 03-13-38->0s=0:00:00.000544s status=OK step=show plc=plctest1_vplc14 force=False * 03:13:38 -- ********** 1 RUNNING step plcvm_delete on plc plctest1_vplc14 -> 03:13:38 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks mkdir -p 2024.07.02--f39-nofed Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:13:38 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2024.07.02--f39-nofed ';' rm -f /vservers/2024.07.02--f39-nofed-1-vplc14/2024.07.02--f39-nofed-1-vplc14.timestamp Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:13:39 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2024.07.02--f39-nofed ';' virsh -c lxc:/// destroy 2024.07.02--f39-nofed-1-vplc14 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. error: failed to get domain '2024.07.02--f39-nofed-1-vplc14' -> 03:13:39 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2024.07.02--f39-nofed ';' virsh -c lxc:/// undefine 2024.07.02--f39-nofed-1-vplc14 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. error: failed to get domain '2024.07.02--f39-nofed-1-vplc14' -> 03:13:40 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2024.07.02--f39-nofed ';' rm -fr /vservers/2024.07.02--f39-nofed-1-vplc14 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. * 03:13:40 -- ********** 1 SUCCESSFUL step plcvm_delete on plctest1_vplc14 TRACE: 1 03-13-38->1s=0:00:01.851698s status=OK step=plcvm_delete plc=plctest1_vplc14 force=False * 03:13:40 -- ********** 1 RUNNING step plcvm_timestamp on plc plctest1_vplc14 -> 03:13:40 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks mkdir -p /vservers/2024.07.02--f39-nofed-1-vplc14 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:13:40 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks echo 1719882820 '>' /vservers/2024.07.02--f39-nofed-1-vplc14/2024.07.02--f39-nofed-1-vplc14.timestamp Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. * 03:13:41 -- ********** 1 SUCCESSFUL step plcvm_timestamp on plctest1_vplc14 TRACE: 1 03-13-40->0s=0:00:00.737819s status=OK step=plcvm_timestamp plc=plctest1_vplc14 force=False * 03:13:41 -- ********** 1 RUNNING step plcvm_create on plc plctest1_vplc14 -> 03:13:41 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks rm -rf 2024.07.02--f39-nofed/build Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. -> 03:13:41 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -r build buzzcocks:2024.07.02--f39-nofed/build -> 03:13:43 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks cd 2024.07.02--f39-nofed ';' build/lbuild-initvm.sh -p linux64 -d lxc -f f39 -r http://build.onelab.eu/lxc//2024.07.02--f39-nofed/RPMS -n vplc14.pl.sophia.inria.fr 2024.07.02--f39-nofed-1-vplc14 Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. Bridge already set up - skipping create_bridge_if_needed + set -e + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift + local fcdistro=f39 + shift + local pldistro=lxc + shift + local personality=linux64 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 ++ package_method f39 ++ local fcdistro=f39 ++ shift ++ case $fcdistro in ++ echo dnf + pkg_method=dnf + case $pkg_method in + '[' -z '' ']' + fedora_install 2024.07.02--f39-nofed-1-vplc14 + set -x + set -e + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 + local cache=/var/cache/lxc/fedora/x86_64/39 + mkdir -p /var/cache/lxc/fedora/x86_64/39 + flock --exclusive --timeout 60 200 + '[' '!' -e /var/cache/lxc/fedora/x86_64/39/rootfs ']' + echo 'Updating cache /var/cache/lxc/fedora/x86_64/39/rootfs ...' Updating cache /var/cache/lxc/fedora/x86_64/39/rootfs ... + dnf --installroot /var/cache/lxc/fedora/x86_64/39/rootfs --releasever=39 -y --nogpgcheck update Last metadata expiration check: 0:08:40 ago on Tue Jul 2 03:05:05 2024. Dependencies resolved. Nothing to do. Complete! Update finished Filling /vservers/2024.07.02--f39-nofed-1-vplc14 from /var/cache/lxc/fedora/x86_64/39/rootfs ... + echo 'Update finished' + echo 'Filling /vservers/2024.07.02--f39-nofed-1-vplc14 from /var/cache/lxc/fedora/x86_64/39/rootfs ... ' + rsync -a /var/cache/lxc/fedora/x86_64/39/rootfs/ /vservers/2024.07.02--f39-nofed-1-vplc14/ + return 0 + return 0 ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + chroot /vservers/2024.07.02--f39-nofed-1-vplc14 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 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + chroot /vservers/2024.07.02--f39-nofed-1-vplc14 linux64 rpm --rebuilddb + fedora_configure 2024.07.02--f39-nofed-1-vplc14 f39 + set -x + set -e + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift + local fcdistro=f39 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 + mkdir -p /vservers/2024.07.02--f39-nofed-1-vplc14/selinux + echo 0 + cat + cat + local dev_path=/vservers/2024.07.02--f39-nofed-1-vplc14/dev + rm -rf /vservers/2024.07.02--f39-nofed-1-vplc14/dev + mkdir -p /vservers/2024.07.02--f39-nofed-1-vplc14/dev + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/null c 1 3 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/zero c 1 5 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/random c 1 8 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/urandom c 1 9 + mkdir -m 755 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/pts + mkdir -m 1777 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/shm + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty c 5 0 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty0 c 4 0 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty1 c 4 1 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty2 c 4 2 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty3 c 4 3 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/tty4 c 4 4 + mknod -m 600 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/console c 5 1 + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/full c 1 7 + mknod -m 600 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/initctl p + mknod -m 666 /vservers/2024.07.02--f39-nofed-1-vplc14/dev/ptmx c 5 2 + fedora_configure_systemd 2024.07.02--f39-nofed-1-vplc14 + set -e + set -x + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 + '[' -d /vservers/2024.07.02--f39-nofed-1-vplc14/etc/systemd ']' + ln -sf /lib/systemd/system/multi-user.target /vservers/2024.07.02--f39-nofed-1-vplc14/etc/systemd/system/default.target + touch /vservers/2024.07.02--f39-nofed-1-vplc14/etc/fstab + ln -sf /dev/null /vservers/2024.07.02--f39-nofed-1-vplc14/etc/systemd/system/udev.service + ln -sf /dev/null /vservers/2024.07.02--f39-nofed-1-vplc14/etc/systemd/system/getty@.service + rm -f /vservers/2024.07.02--f39-nofed-1-vplc14/etc/systemd/system/getty.target.wants/getty@tty1.service + chroot /vservers/2024.07.02--f39-nofed-1-vplc14 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 2024.07.02--f39-nofed-1-vplc14 + local lxc=2024.07.02--f39-nofed-1-vplc14 + case $(network_config_method $fcdistro) in ++ network_config_method f39 ++ local fcdistro=f39 ++ shift ++ case $fcdistro in ++ echo networkmanager + local 'guest_keyfile=/vservers/2024.07.02--f39-nofed-1-vplc14/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' ++ dirname '/vservers/2024.07.02--f39-nofed-1-vplc14/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' + mkdir -p /vservers/2024.07.02--f39-nofed-1-vplc14/etc/NetworkManager/system-connections + '[' -n '' ']' + write_guest_networkmanager_publicip + cat ++ uuid ++ python -c 'import uuid; print(uuid.uuid1())' + chmod 600 '/vservers/2024.07.02--f39-nofed-1-vplc14/etc/NetworkManager/system-connections/Wired connection 1.nmconnection' + '[' -z '' ']' + fedora_configure_yum 2024.07.02--f39-nofed-1-vplc14 f39 lxc + set -x + set -e + trap failure ERR INT + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift + local fcdistro=f39 + shift + local pldistro=lxc + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 + chroot /vservers/2024.07.02--f39-nofed-1-vplc14 linux64 rpm --rebuilddb Initializing yum.repos.d in 2024.07.02--f39-nofed-1-vplc14 + '[' -z '' ']' + echo 'Initializing yum.repos.d in 2024.07.02--f39-nofed-1-vplc14' + rm -f /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora-cisco-openh264.repo /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora-updates-testing.repo /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora-updates.repo /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora-updates.repo.rpmnew /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora.repo /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/fedora.repo.rpmnew + local repofile=/vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo + yumconf_mirrors /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo build f39 '' http://mirror.onelab.eu/ + dest_yumconf=/vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo + shift + builddir=build + shift + fcdistro=f39 + shift + yumexclude_line= + shift + mirrors=http://mirror.onelab.eu/ + template=build/mirroring/f39/yum.repos.d/building.repo.in + '[' '!' -f build/mirroring/f39/yum.repos.d/building.repo.in ']' + for mirror in $mirrors + yumconf_mirror /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo build/mirroring/f39/yum.repos.d/building.repo.in '' http://mirror.onelab.eu/ + dest_yumconf=/vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo + shift + template=build/mirroring/f39/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/f39/yum.repos.d/building.repo.in ++ grep '^baseurl=' /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo + baseurl_defs='baseurl=http://mirror.onelab.eu//fedora/releases/39/Everything/$basearch/os/ baseurl=http://mirror.onelab.eu//fedora/updates/39/Everything/$basearch/ baseurl=http://mirror.onelab.eu//fedora/updates/39/Modular/$basearch/' + '[' -z 'baseurl=http://mirror.onelab.eu//fedora/releases/39/Everything/$basearch/os/ baseurl=http://mirror.onelab.eu//fedora/updates/39/Everything/$basearch/ baseurl=http://mirror.onelab.eu//fedora/updates/39/Modular/$basearch/' ']' + for baseurl_def in $baseurl_defs ++ echo 'baseurl=http://mirror.onelab.eu//fedora/releases/39/Everything/$basearch/os/' ++ sed -e s,baseurl=,, -e 's,$basearch,x86_64,g' + baseurl=http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os/ + repomd=http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml * Trying to fetch http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml + echo '* Trying to fetch http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml' + build_fetch http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml + curl --fail --silent --max-time 60 --output /dev/null http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml * Failed to fetch http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml + echo '* Failed to fetch http://mirror.onelab.eu//fedora/releases/39/Everything/x86_64/os//repodata/repomd.xml' + return 1 yumconf_mirrors in build.common : ran out of mirrors -- BAILING OUT + echo 'yumconf_mirrors in build.common : ran out of mirrors -- BAILING OUT' + rm -f /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo + return 1 + sed -i /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo -e 's,gpgkey=.*,gpgkey=http://mirror.onelab.eu/keys//RPM-GPG-KEY-fedora-39-primary,' sed: can't read /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/building.repo: No such file or directory + rpm --root /vservers/2024.07.02--f39-nofed-1-vplc14 --import http://mirror.onelab.eu/keys//RPM-GPG-KEY-fedora-39-primary curl: (28) Failed to connect to mirror.onelab.eu port 80 after 134266 ms: Couldn't connect to server error: http://mirror.onelab.eu/keys//RPM-GPG-KEY-fedora-39-primary: import read failed(2). + '[' -n http://build.onelab.eu/lxc//2024.07.02--f39-nofed/RPMS ']' + '[' '!' -d /vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d ']' ++ pl_plcyumexclude f39 lxc build ++ pl_yumexclude plcyumexclude f39 lxc build ++ keyword=plcyumexclude ++ shift ++ fcdistro=f39 ++ 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 f39 -d lxc plcyumexclude build/config.lxc/yumexclude.pkgs + yumexclude=drupal + for repo in $lxc_root/etc/yum.repos.d/* + '[' -f '/vservers/2024.07.02--f39-nofed-1-vplc14/etc/yum.repos.d/*' ']' + cat + return 0 + '[' -d /vservers/2024.07.02--f39-nofed-1-vplc14/cgroup ']' + mkdir /vservers/2024.07.02--f39-nofed-1-vplc14/cgroup + '[' -h /vservers/2024.07.02--f39-nofed-1-vplc14/etc/resolv.conf ']' + rm -f /vservers/2024.07.02--f39-nofed-1-vplc14/etc/resolv.conf + '[' -f /etc/resolv.conf.containers ']' + cp /etc/resolv.conf.containers /vservers/2024.07.02--f39-nofed-1-vplc14/etc/resolv.conf + '[' -f /vservers/2024.07.02--f39-nofed-1-vplc14/etc/hosts ']' + mkdir -p /vservers/2024.07.02--f39-nofed-1-vplc14/root/.ssh + cat /root/.ssh/id_rsa.pub + chmod 700 /vservers/2024.07.02--f39-nofed-1-vplc14/root/.ssh + chmod 600 /vservers/2024.07.02--f39-nofed-1-vplc14/root/.ssh/authorized_keys + local config_xml=/tmp/2024.07.02--f39-nofed-1-vplc14.xml + '[' -n '' ']' + write_lxc_xml_publicip 2024.07.02--f39-nofed-1-vplc14 + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 + cat + virsh -c lxc:/// define /tmp/2024.07.02--f39-nofed-1-vplc14.xml Domain '2024.07.02--f39-nofed-1-vplc14' defined from /tmp/2024.07.02--f39-nofed-1-vplc14.xml + return 0 + devel_or_test_tools 2024.07.02--f39-nofed-1-vplc14 f39 lxc linux64 + set -x + set -e + trap failure ERR INT + local lxc=2024.07.02--f39-nofed-1-vplc14 + shift + local fcdistro=f39 + shift + local pldistro=lxc + shift + local personality=linux64 + shift ++ lxcroot 2024.07.02--f39-nofed-1-vplc14 ++ local lxc=2024.07.02--f39-nofed-1-vplc14 ++ shift ++ echo /vservers/2024.07.02--f39-nofed-1-vplc14 + local lxc_root=/vservers/2024.07.02--f39-nofed-1-vplc14 ++ package_method f39 ++ local fcdistro=f39 ++ 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/2024.07.02--f39-nofed-1-vplc14 linux64 arch + local lxc_arch=x86_64 + '[' x86_64 = unknown ']' ++ pl_getPackages -a x86_64 f39 lxc build/config.planetlab/runtime.pkgs ++ pl_parsePkgs package -a x86_64 f39 lxc build/config.planetlab/runtime.pkgs ++ target_arch=x86_64 ++ keyword=package ++ shift ++ '[' -a == -a ']' ++ shift ++ target_arch=x86_64 ++ shift ++ fcdistro=f39 ++ shift ++ pldistro=lxc ++ shift ++ echo 'pl_parsePkgs: using -a x86_64 -f f39 -d lxc package build/config.planetlab/runtime.pkgs' pl_parsePkgs: using -a x86_64 -f f39 -d lxc package build/config.planetlab/runtime.pkgs ++ pkgs.py -a x86_64 -f f39 -d lxc package build/config.planetlab/runtime.pkgs build/config.planetlab/runtime.pkgs:9:syntax error: error in left expression package=jammy + local 'packages=NetworkManager bind-utils curl emacs-nox file hostname openssh-clients psmisc' ++ pl_getGroups -a x86_64 f39 lxc build/config.planetlab/runtime.pkgs ++ pl_parsePkgs group -a x86_64 f39 lxc build/config.planetlab/runtime.pkgs ++ target_arch=x86_64 ++ keyword=group ++ shift ++ '[' -a == -a ']' ++ shift ++ target_arch=x86_64 ++ shift ++ fcdistro=f39 ++ shift ++ pldistro=lxc ++ shift ++ echo 'pl_parsePkgs: using -a x86_64 -f f39 -d lxc group build/config.planetlab/runtime.pkgs' pl_parsePkgs: using -a x86_64 -f f39 -d lxc group build/config.planetlab/runtime.pkgs ++ pkgs.py -a x86_64 -f f39 -d lxc group build/config.planetlab/runtime.pkgs build/config.planetlab/runtime.pkgs:9:syntax error: error in left expression package=jammy + local groups= + case "$pkg_method" in + local has_dnf= + chroot /vservers/2024.07.02--f39-nofed-1-vplc14 linux64 dnf --version 4.19.2 Installed: dnf-0:4.19.2-1.fc39.noarch at Mon Apr 1 01:05:19 2024 Built : Fedora Project at Fri Mar 29 18:55:12 2024 Installed: rpm-0:4.19.1.1-1.fc39.x86_64 at Sat Feb 17 02:05:16 2024 Built : Fedora Project at Wed Feb 7 16:05:57 2024 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/2024.07.02--f39-nofed-1-vplc14 linux64 dnf -y install --allowerasing NetworkManager bind-utils curl emacs-nox file hostname openssh-clients psmisc MyPLC 302 kB/s | 14 kB 00:00 No match for argument: NetworkManager No match for argument: bind-utils Package curl-8.2.1-5.fc39.x86_64 is already installed. No match for argument: emacs-nox No match for argument: file No match for argument: hostname Package openssh-clients-9.3p1-10.fc39.x86_64 is already installed. Package psmisc-23.6-4.fc39.x86_64 is already installed. Error: Unable to find a match: NetworkManager bind-utils emacs-nox file hostname lbuild-initvm.sh : Bailing out ++ failure ++ echo 'lbuild-initvm.sh : Bailing out' ++ exit 1 * 03:17:03 -- ********** 1 FAILED step plcvm_create on plctest1_vplc14 (discarded from further steps) TRACE: 1 03-13-41->202s=0:03:22.597288s status=KO step=plcvm_create plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step django_install on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000218s status=UNDEF step=django_install plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step plc_install on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000112s status=UNDEF step=plc_install plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step plc_configure on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000092s status=UNDEF step=plc_configure plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step plc_start on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000095s status=UNDEF step=plc_start plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step keys_fetch on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000088s status=UNDEF step=keys_fetch plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step keys_store on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000091s status=UNDEF step=keys_store plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step keys_clear_known_hosts on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000089s status=UNDEF step=keys_clear_known_hosts plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step plcapi_urls on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000092s status=UNDEF step=plcapi_urls plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step speed_up_slices on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000088s status=UNDEF step=speed_up_slices plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step initscripts on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000087s status=UNDEF step=initscripts plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step sites on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000096s status=UNDEF step=sites plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step nodes on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000095s status=UNDEF step=nodes plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step slices on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000089s status=UNDEF step=slices plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step nodegroups on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000088s status=UNDEF step=nodegroups plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 SKIPPED Step leases on plctest1_vplc14 (has failed plcvm_create) TRACE: 1 03-17-03->0s=0:00:00.000088s status=UNDEF step=leases plc=plctest1_vplc14 force=False * 03:17:03 -- ********** 1 RUNNING step gather_logs (forced after plcvm_create has failed) on plc plctest1_vplc14 -------------------- TestPlc.gather_logs : PLC's /var/log -> 03:17:03 -- + mkdir -p logs/myplc.var-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -> 03:17:03 -- + 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 vplc14 tar -C /var/log/ -cf - . + tar -C logs/myplc.var-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc14 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:17:07 -- + chmod a+r,a+x logs/myplc.var-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14/httpd chmod: cannot access 'logs/myplc.var-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14/httpd': No such file or directory -------------------- TestPlc.gather_logs : PLC's /var/lib/psql/data/pg_log/ -> 03:17:07 -- + mkdir -p logs/myplc.pgsql-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -> 03:17:07 -- + 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 vplc14 tar -C /var/lib/pgsql/data/pg_log/ -cf - . + tar -C logs/myplc.pgsql-log.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc14 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:17:10 -- + mkdir -p logs/sfi.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -> 03:17:10 -- + 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 vplc14 tar -C /root/sfi/ -cf - . + tar -C logs/sfi.plctest1_vplc14.2024.07.02--f39-nofed-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ED25519) to the list of known hosts. ssh: connect to host vplc14 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:17:14 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 boxtops:/vservers/2024.07.02--f39-nofed/qemu-vnode01.pl.sophia.inria.fr/log.txt logs/node.qemu.vnode01.pl.sophia.inria.fr.txt scp: /vservers/2024.07.02--f39-nofed/qemu-vnode01.pl.sophia.inria.fr/log.txt: No such file or directory -------------------- TestPlc.gather_logs : nodes's /var/log -> 03:17:14 -- + mkdir -p logs/node.var-log.vnode01.pl.sophia.inria.fr -> 03:17:14 -- + 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/2024.07.02--f39-nofed/TestMain.py", line 511, in run step_result = method(plc_obj) ^^^^^^^^^^^^^^^ File "/root/2024.07.02--f39-nofed/TestPlc.py", line 1929, in gather_logs self.gather_slivers_var_logs() File "/root/2024.07.02--f39-nofed/TestPlc.py", line 1933, in gather_slivers_var_logs for test_sliver in self.all_sliver_objs(): ^^^^^^^^^^^^^^^^^^^^^^ File "/root/2024.07.02--f39-nofed/TestPlc.py", line 427, in all_sliver_objs result.append(self.locate_sliver_obj(nodename, slicename)) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/root/2024.07.02--f39-nofed/TestPlc.py", line 438, in locate_sliver_obj return TestSliver(self, test_node, test_slice) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/root/2024.07.02--f39-nofed/TestSliver.py", line 16, in __init__ self.test_ssh = self.create_test_ssh() ^^^^^^^^^^^^^^^^^^^^^^ File "/root/2024.07.02--f39-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:17:17 -- ********** 1 FAILED (exception) step gather_logs on plctest1_vplc14 (discarded from further steps) TRACE: 1 03-17-03->14s=0:00:14.120809s status=KO step=gather_logs plc=plctest1_vplc14 force=True TestMain exit code 1