DEBUG: Executing python function extend_recipe_sysroot NOTE: Direct dependencies are ['/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/qemu/qemu-helper-native_1.0.bb:do_populate_sysroot', '/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/qemu/qemu-native_7.2.0.bb:do_populate_sysroot', '/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/qemu/qemu-system-native_7.2.0.bb:do_populate_sysroot', 'virtual:native:/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/createrepo-c/createrepo-c_0.20.1.bb:do_populate_sysroot', 'virtual:native:/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/dnf/dnf_4.14.0.bb:do_populate_sysroot', 'virtual:native:/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/pseudo/pseudo_git.bb:do_populate_sysroot', 'virtual:native:/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-devtools/unfs3/unfs3_git.bb:do_populate_sysroot', 'virtual:native:/home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/recipes-extended/cpio/cpio_2.13.bb:do_populate_sysroot'] NOTE: Installed into sysroot: ['cpio-native'] NOTE: Skipping as already exists in sysroot: ['qemu-helper-native', 'qemu-native', 'qemu-system-native', 'createrepo-c-native', 'dnf-native', 'pseudo-native', 'unfs3-native', 'xz-native', 'zlib-native', 'glib-2.0-native', 'gettext-minimal-native', 'texinfo-dummy-native', 'libtool-native', 'libtirpc-native', 'flex-native', 'libcomps-native', 'cmake-native', 'libdnf-native', 'python3-iniparse-native', 'librepo-native', 'python3-native', 'libslirp-native', 'pixman-native', 'libsdl2-native', 'dtc-native', 'virglrenderer-native', 'libepoxy-native', 'alsa-lib-native', 'rpm-native', 'libxml2-native', 'curl-native', 'openssl-native', 'sqlite3-native', 'file-native', 'expat-native', 'libffi-native', 'util-linux-native', 'libpcre2-native', 'gettext-native', 'm4-native', 'libcheck-native', 'zstd-native', 'bzip2-native', 'ncurses-native', 'swig-native', 'json-c-native', 'libsolv-native', 'gobject-introspection-native', 'libmodulemd-native', 'python3-setuptools-native', 'python3-six-native', 'python3-wheel-native', 'python3-build-native', 'python3-installer-native', 'gpgme-native', 'attr-native', 'libnsl2-native', 'util-linux-libuuid-native', 'gdbm-native', 'readline-native', 'libx11-native', 'mesa-native', 'libxext-native', 'libxrandr-native', 'libxrender-native', 'libdrm-native', 'popt-native', 'lua-native', 'elfutils-native', 'libgcrypt-native', 'perl-native', 'libcap-ng-native', 'gnu-config-native', 'libyaml-native', 'python3-flit-core-native', 'python3-pyproject-hooks-native', 'python3-packaging-native', 'libgpg-error-native', 'libassuan-native', 'xtrans-native', 'util-macros-native', 'libxcb-native', 'xorgproto-native', 'llvm-native', 'wayland-protocols-native', 'makedepend-native', 'python3-mako-native', 'libxshmfence-native', 'chrpath-native', 'libxdamage-native', 'libxfixes-native', 'libxxf86vm-native', 'xrandr-native', 'wayland-native', 'libpciaccess-native', 'libpthread-stubs-native', 'libmicrohttpd-native', 'libarchive-native', 'libcap-native', 'make-native', 'unzip-native', 'libxdmcp-native', 'libxau-native', 'xcb-proto-native', 'libedit-native', 'python3-markupsafe-native', 'python3-pygments-native', 'gnutls-native', 'libunistring-native', 'nettle-native', 'gmp-native', 'libidn2-native'] DEBUG: Python function extend_recipe_sysroot finished DEBUG: Executing python function do_testimage DEBUG: test suites: test_ping (ping.PingTest) test_ssh (ssh.SSHTest) test_parselogs (parselogs.ParseLogsTest) test_ptestrunner_expectfail (ptest.PtestRunnerTest) test_ptestrunner_expectsuccess (ptest.PtestRunnerTest) DEBUG: Using kvm for runqemu QMP Available for connection at /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.pky48s81 DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:48657 DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:58871 DEBUG: launchcmd=runqemu snapshot kvm qemuarm64 /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/core-image-ptest-libgcrypt-qemuarm64.ext4 tcpserial=48657:58871 bootparams=" printk.time=1" qemuparams="-pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_132201 -S -qmp unix:./.8z2glcpy,server,wait -qmp unix:./.pky48s81,server,nowait" DEBUG: runqemu started, pid is 132665 DEBUG: waiting at most 300 seconds for qemu pid (03/24/23 11:01:33) DEBUG: QMP Initializing to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.8z2glcpy DEBUG: QMP Connecting to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.8z2glcpy QMP connected to QEMU at 03/24/23 11:01:35 and took 1.9342174530029297 seconds QMP released QEMU at 03/24/23 11:01:35 and took 0.3595271110534668 seconds from connect DEBUG: qemu started in 2.281106472015381 seconds - qemu procces pid is 133081 (03/24/23 11:01:35) DEBUG: qemu cmdline used: /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/aarch64-linux/qemu-helper-native/1.0-r1/recipe-sysroot-native/usr/bin/qemu-system-aarch64 -device virtio-net-pci,netdev=net0,mac=52:54:00:12:34:1c -netdev tap,id=net0,ifname=tap13,script=no,downscript=no -object rng-random,filename=/dev/urandom,id=rng0 -device virtio-rng-pci,rng=rng0 -drive id=disk0,file=/home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.132687,if=none,format=raw -device virtio-blk-pci,drive=disk0 -device qemu-xhci -device usb-tablet -device usb-kbd -machine virt -cpu host -machine gic-version=3 -smp 4 -enable-kvm -m 1024 -device virtio-serial-pci -chardev socket,id=virtcon,port=48657,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:58871 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_132201 -S -qmp unix:./.8z2glcpy,server,wait -qmp unix:./.pky48s81,server,nowait -serial mon:vc -display sdl,show-cursor=on -device virtio-gpu-pci -kernel /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/Image -append root=/dev/vda rw mem=1024M ip=192.168.7.28::192.168.7.27:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1 DEBUG: Target IP: 192.168.7.28 DEBUG: Server IP: 192.168.7.27 DEBUG: Starting logging thread DEBUG: Starting thread event loop DEBUG: Connection request received DEBUG: Setting connection established event DEBUG: Output from runqemu: runqemu - INFO - Continuing with the following parameters: KERNEL: [/home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/Image] MACHINE: [qemuarm64] FSTYPE: [ext4] ROOTFS: [/home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/core-image-ptest-libgcrypt-qemuarm64.ext4] CONFFILE: [/home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/core-image-ptest-libgcrypt-qemuarm64.qemuboot.conf] runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap0.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap1.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap2.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap3.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap4.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap5.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap6.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap7.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap8.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap9.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap10.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap11.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Acquiring lockfile /tmp/qemu-tap-locks/tap12.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Using preconfigured tap device tap13 runqemu - INFO - If this is not intended, touch /tmp/qemu-tap-locks/tap13.skip to make runqemu skip tap13. runqemu - INFO - Network configuration: ip=192.168.7.28::192.168.7.27:255.255.255.0::eth0:off:8.8.8.8 runqemu - INFO - Copying rootfs to /home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.132687 runqemu - INFO - Copy done in 0.8168368339538574 seconds runqemu - INFO - Running /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/aarch64-linux/qemu-helper-native/1.0-r1/recipe-sysroot-native/usr/bin/qemu-system-aarch64 -device virtio-net-pci,netdev=net0,mac=52:54:00:12:34:1c -netdev tap,id=net0,ifname=tap13,script=no,downscript=no -object rng-random,filename=/dev/urandom,id=rng0 -device virtio-rng-pci,rng=rng0 -drive id=disk0,file=/home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.132687,if=none,format=raw -device virtio-blk-pci,drive=disk0 -device qemu-xhci -device usb-tablet -device usb-kbd -machine virt -cpu host -machine gic-version=3 -smp 4 -enable-kvm -m 1024 -device virtio-serial-pci -chardev socket,id=virtcon,port=48657,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:58871 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_132201 -S -qmp unix:./.8z2glcpy,server,wait -qmp unix:./.pky48s81,server,nowait -serial mon:vc -display sdl,show-cursor=on -device virtio-gpu-pci -kernel /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/Image -append 'root=/dev/vda rw mem=1024M ip=192.168.7.28::192.168.7.27:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1' runqemu - INFO - Host uptime: 321429.16 DEBUG: Waiting at most 1500 seconds for login banner (03/24/23 11:01:35) DEBUG: Connection from 127.0.0.1:38360 DEBUG: Reached login banner in 9.57633924484253 seconds (03/24/23 11:01:45, 1679655705.2469575) DEBUG: Logged as root in serial console NOTE: test_ping (ping.PingTest) DEBUG: Setting up a 30 second(s) timeout DEBUG: Removed SIGALRM handler NOTE: ... ok NOTE: test_ssh (ssh.SSHTest) DEBUG: Checking if at least one of openssh-sshd, dropbear is installed DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -a DEBUG: Waiting for process output: time: 1679655708.5441546, endtime: 1679656008.5305753 DEBUG: Partial data from SSH call: Linux qemuarm64 6.1.14-yocto-standard #1 SMP PREEMPT Mon Feb 27 14:44:30 UTC 2023 aarch64 GNU/Linux DEBUG: Waiting for process output: time: 1679655708.9078405, endtime: 1679656008.9078376 DEBUG: Data from SSH call: Linux qemuarm64 6.1.14-yocto-standard #1 SMP PREEMPT Mon Feb 27 14:44:30 UTC 2023 aarch64 GNU/Linux DEBUG: [Command returned '0' after 0.58 seconds] DEBUG: Command: uname -a Status: 0 Output: Linux qemuarm64 6.1.14-yocto-standard #1 SMP PREEMPT Mon Feb 27 14:44:30 UTC 2023 aarch64 GNU/Linux DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /etc/controllerimage DEBUG: Waiting for process output: time: 1679655709.139006, endtime: 1679656009.110438 DEBUG: Partial data from SSH call: cat: can't open '/etc/controllerimage': No such file or directory DEBUG: Waiting for process output: time: 1679655709.5337257, endtime: 1679656009.5337226 DEBUG: Data from SSH call: cat: can't open '/etc/controllerimage': No such file or directory DEBUG: [Command returned '1' after 0.63 seconds] DEBUG: Command: cat /etc/controllerimage Status: 1 Output: cat: can't open '/etc/controllerimage': No such file or directory NOTE: ... ok DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; which LSB_Test.sh DEBUG: Waiting for process output: time: 1679655709.750584, endtime: 1679656009.7372468 DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.40 seconds] DEBUG: Command: which LSB_Test.sh Status: 1 Output: NOTE: test_parselogs (parselogs.ParseLogsTest) DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg > /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1679655710.1645288, endtime: 1679656010.1354456 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.41 seconds] DEBUG: Command: dmesg > /tmp/dmesg_output.log Status: 0 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/ DEBUG: Waiting for process output: time: 1679655710.574811, endtime: 1679656010.5510898 DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.39 seconds] DEBUG: Command: test -f /var/log/ Status: 1 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -d /var/log/ DEBUG: Waiting for process output: time: 1679655710.9660113, endtime: 1679656010.9466665 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.38 seconds] DEBUG: Command: test -d /var/log/ Status: 0 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; find /var/log//*.log -maxdepth 1 -type f DEBUG: Waiting for process output: time: 1679655711.3478994, endtime: 1679656011.3317251 DEBUG: Partial data from SSH call: /var/log//postinstall.log DEBUG: Waiting for process output: time: 1679655711.714064, endtime: 1679656011.714061 DEBUG: Data from SSH call: /var/log//postinstall.log DEBUG: [Command returned '0' after 0.58 seconds] DEBUG: Command: find /var/log//*.log -maxdepth 1 -type f Status: 0 Output: /var/log//postinstall.log DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/dmesg DEBUG: Waiting for process output: time: 1679655711.931058, endtime: 1679656011.9171948 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.43 seconds] DEBUG: Command: test -f /var/log/dmesg Status: 0 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1679655712.3599534, endtime: 1679656012.3438976 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.39 seconds] DEBUG: Command: test -f /tmp/dmesg_output.log Status: 0 Output: DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.28:/var/log//postinstall.log /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-libgcrypt/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.22 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.28:/var/log/dmesg /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-libgcrypt/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.19 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.28:/tmp/dmesg_output.log /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-libgcrypt/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.21 seconds] DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /proc/cpuinfo | grep "model name" | head -n1 | awk 'BEGIN{FS=":"}{print $2}' DEBUG: Waiting for process output: time: 1679655713.5150497, endtime: 1679656013.5009177 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.41 seconds] DEBUG: Command: cat /proc/cpuinfo | grep "model name" | head -n1 | awk 'BEGIN{FS=":"}{print $2}' Status: 0 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /proc/cpuinfo | grep "cpu cores" | head -n1 | awk {'print $4'} DEBUG: Waiting for process output: time: 1679655713.9396167, endtime: 1679656013.9144464 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.41 seconds] DEBUG: Command: cat /proc/cpuinfo | grep "cpu cores" | head -n1 | awk {'print $4'} Status: 0 Output: DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /proc/cpuinfo | grep "processor" | wc -l DEBUG: Waiting for process output: time: 1679655714.3720107, endtime: 1679656014.3235338 DEBUG: Partial data from SSH call: 4 DEBUG: Waiting for process output: time: 1679655714.7816439, endtime: 1679656014.781641 DEBUG: Data from SSH call: 4 DEBUG: [Command returned '0' after 0.66 seconds] DEBUG: Command: cat /proc/cpuinfo | grep "processor" | wc -l Status: 0 Output: 4 DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -m DEBUG: Waiting for process output: time: 1679655715.0123868, endtime: 1679656014.9840145 DEBUG: Partial data from SSH call: aarch64 DEBUG: Waiting for process output: time: 1679655715.4475749, endtime: 1679656015.447571 DEBUG: Data from SSH call: aarch64 DEBUG: [Command returned '0' after 0.67 seconds] DEBUG: Command: uname -m Status: 0 Output: aarch64 NOTE: ... ok NOTE: test_ptestrunner_expectfail (ptest.PtestRunnerTest) DEBUG: Checking if at least one of ptest-runner is installed DEBUG: Checking if ptest is in DISTRO_FEATURES or IMAGE_FEATURES DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; which ptest-runner DEBUG: Data from SSH call: /usr/bin/ptest-runner DEBUG: [Command returned '0' after 0.22 seconds] DEBUG: Command: which ptest-runner Status: 0 Output: /usr/bin/ptest-runner DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; ptest-runner -t 450 -d "/usr/lib" DEBUG: Data from SSH call: START: ptest-runner 2023-03-24T11:01 BEGIN: /usr/lib/libgcrypt/ptest version:1.10.1-unknown:10a01:1.46-unknown:12e00: cc:120200:gcc:12.2.0: ciphers:arcfour:blowfish:cast5:des:aes:twofish:serpent:rfc2268:seed:camellia:idea:salsa20:gost28147:chacha20:sm4: pubkeys:dsa:elgamal:rsa:ecc: digests:crc:gostr3411-94::md4:md5:rmd160:sha1:sha256:sha512:sha3:tiger:whirlpool:stribog:blake2:sm3: rnd-mod:getentropy: cpu-arch:: mpi-asm:generic/mpih-add1.c:generic/mpih-sub1.c:generic/mpih-mul1.c:generic/mpih-mul2.c:generic/mpih-mul3.c:generic/mpih-lshift.c:generic/mpih-rshift.c: hwflist: fips-mode:n::: rng-type:standard:1:3030000:2: compliance::: PASS: version PASS: t-secmem PASS: mpitests PASS: t-sexp PASS: t-convert PASS: t-mpi-bit PASS: t-mpi-point PASS: curves PASS: t-lock PASS: prime PASS: basic PASS: basic-disable-all-hwf PASS: keygen PASS: pubkey PASS: hmac PASS: hashtest PASS: t-kdf PASS: keygrip PASS: fips186-dsa PASS: aeswrap PASS: pkcs1v2 PASS: random PASS: dsa-rfc6979 t-ed25519: 256 of 1026 tests done t-ed25519: 512 of 1026 tests done t-ed25519: 768 of 1026 tests done t-ed25519: 1024 of 1026 tests done t-ed25519: 1026 tests done PASS: t-ed25519 t-cv25519: 18 tests done PASS: t-cv25519 t-x448: 9 tests done PASS: t-x448 t-ed448: 11 tests done PASS: t-ed448 Note: benchmark running in quick regression test mode. MD5 0ms 0ms 40ms 10ms 0ms SHA1 0ms 10ms 30ms 10ms 0ms RIPEMD160 0ms 10ms 30ms 10ms 0ms TIGER192 10ms 0ms 40ms 10ms 0ms SHA256 0ms 10ms 30ms 20ms 0ms SHA384 10ms 0ms 30ms 10ms 0ms SHA512 10ms 0ms 30ms 10ms 0ms SHA224 10ms 10ms 40ms 10ms 10ms MD4 0ms 0ms 30ms 0ms 0ms CRC32 10ms 0ms 10ms 10ms 0ms CRC32RFC1510 0ms 0ms 10ms 10ms 0ms CRC24RFC2440 0ms 0ms 10ms 10ms 0ms WHIRLPOOL 20ms 10ms 40ms 20ms 10ms TIGER 10ms 0ms 30ms 10ms 0ms TIGER2 0ms 10ms 20ms 10ms 0ms GOSTR3411_94 30ms 40ms 60ms 50ms 30ms STRIBOG256 20ms 20ms 40ms 20ms 30ms STRIBOG512 20ms 20ms 40ms 20ms 20ms GOSTR3411_CP 30ms 30ms 50ms 30ms 30ms SHA3-224 0ms 0ms 40ms 10ms 0ms SHA3-256 0ms 10ms 40ms 10ms 0ms SHA3-384 0ms 10ms 40ms 10ms 10ms SHA3-512 10ms 10ms 40ms 10ms 10ms SHAKE128 0ms 10ms 30ms 10ms SHAKE256 10ms 0ms 40ms 0ms BLAKE2B_512 10ms 0ms 20ms 10ms 0ms BLAKE2B_384 0ms 10ms 20ms 10ms 0ms BLAKE2B_256 0ms 10ms 20ms 10ms 0ms BLAKE2B_160 0ms 10ms 30ms 10ms 0ms BLAKE2S_256 0ms 10ms 20ms 10ms 0ms BLAKE2S_224 0ms 10ms 30ms 0ms 10ms BLAKE2S_160 0ms 10ms 20ms 10ms 0ms BLAKE2S_128 10ms 0ms 30ms 10ms 0ms SM3 10ms 10ms 40ms 10ms 0ms SHA512_256 10ms 0ms 40ms 0ms 10ms SHA512_224 0ms 10ms 30ms 10ms 0ms GOST28147_IMIT 10ms 10ms 10ms HMAC_SHA256 10ms 10ms 10ms HMAC_SHA224 10ms 0ms 10ms HMAC_SHA512 10ms 0ms 10ms HMAC_SHA384 0ms 10ms 10ms HMAC_SHA1 10ms 10ms 0ms HMAC_MD5 10ms 0ms 10ms HMAC_MD4 10ms 0ms 0ms HMAC_RIPEMD160 30ms 0ms 10ms HMAC_TIGER 0ms 10ms 10ms HMAC_WHIRLPOOL 10ms 40ms 30ms HMAC_GOSTR3411_94 70ms 30ms 50ms HMAC_STRIBOG256 20ms 20ms 50ms HMAC_STRIBOG512 40ms 20ms 30ms HMAC_SHA3_224 0ms 10ms 10ms HMAC_SHA3_256 10ms 20ms 10ms HMAC_SHA3_384 20ms 10ms 10ms HMAC_SHA3_512 10ms 20ms 20ms HMAC_GOSTR3411_CP 40ms 40ms 50ms HMAC_BLAKE2B_512 10ms 0ms 0ms HMAC_BLAKE2B_384 20ms 0ms 10ms HMAC_BLAKE2B_256 0ms 10ms 0ms HMAC_BLAKE2B_160 0ms 0ms 10ms HMAC_BLAKE2S_256 0ms 10ms 0ms HMAC_BLAKE2S_224 10ms 0ms 10ms HMAC_BLAKE2S_160 0ms 20ms 0ms HMAC_BLAKE2S_128 10ms 0ms 10ms HMAC_SM3 0ms 10ms 10ms HMAC_SHA512_256 10ms 0ms 10ms HMAC_SHA512_224 0ms 10ms 10ms CMAC_AES 10ms 10ms 10ms CMAC_3DES 40ms 40ms 50ms CMAC_CAMELLIA 0ms 10ms 20ms CMAC_CAST5 10ms 10ms 20ms CMAC_BLOWFISH 10ms 10ms 20ms CMAC_TWOFISH 10ms 0ms 20ms CMAC_SERPENT 20ms 10ms 20ms CMAC_SEED 20ms 10ms 30ms CMAC_RFC2268 40ms 20ms 30ms CMAC_IDEA 20ms 20ms 20ms CMAC_GOST28147 40ms 50ms 30ms CMAC_SM4 20ms 20ms 20ms GMAC_AES 0ms 10ms 10ms GMAC_CAMELLIA 0ms 10ms 10ms GMAC_TWOFISH 0ms 10ms 10ms GMAC_SERPENT 0ms 10ms 10ms GMAC_SEED 0ms 10ms 10ms POLY1305 0ms 0ms 10ms POLY1305_AES 0ms 0ms 0ms POLY1305_CAMELLIA 0ms 0ms 10ms POLY1305_TWOFISH 0ms 0ms 0ms POLY1305_SERPENT 10ms 0ms 0ms POLY1305_SEED 0ms 0ms 0ms ECB/Stream CBC/Poly1305 CFB OFB CTR XTS CCM GCM OCB EAX --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- IDEA 20ms 30ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms - - - - - - - - 30ms 40ms 3DES 40ms 40ms 40ms 50ms 40ms 40ms 40ms 50ms 40ms 40ms - - - - - - - - 80ms 90ms CAST5 10ms 20ms 10ms 0ms 20ms 0ms 20ms 10ms 10ms 0ms - - - - - - - - 20ms 20ms BLOWFISH 10ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 20ms 0ms - - - - - - - - 20ms 10ms AES 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms AES192 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 30ms 20ms AES256 20ms 20ms 10ms 20ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 10ms 20ms 30ms 20ms 20ms 10ms 20ms 20ms 30ms TWOFISH 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 10ms 20ms 10ms ARCFOUR 10ms 0ms DES 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms - - - - - - - - 30ms 40ms TWOFISH128 10ms 0ms 20ms 0ms 20ms 0ms 10ms 10ms 10ms 10ms 10ms 0ms 20ms 20ms 20ms 20ms 10ms 10ms 20ms 10ms SERPENT128 20ms 10ms 20ms 20ms 30ms 10ms 20ms 50ms 40ms 20ms 10ms 20ms 40ms 50ms 30ms 30ms 20ms 40ms 30ms 40ms SERPENT192 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 30ms 20ms 70ms 40ms 20ms 40ms 10ms 20ms 40ms 50ms SERPENT256 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 20ms 10ms 20ms 20ms 30ms 40ms 20ms 20ms 20ms 10ms 40ms 30ms RFC2268_40 30ms 20ms 20ms 20ms 30ms 30ms 20ms 30ms 30ms 30ms - - - - - - - - 50ms 60ms RFC2268_128 20ms 20ms 30ms 20ms 20ms 30ms 30ms 20ms 40ms 20ms - - - - - - - - 50ms 80ms SEED 30ms 20ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 20ms 20ms 40ms 40ms CAMELLIA128 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 20ms 20ms 20ms CAMELLIA192 20ms 20ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 30ms 30ms 10ms 20ms 10ms 10ms 30ms 20ms CAMELLIA256 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 20ms 30ms SALSA20 0ms 0ms SALSA20R12 10ms 0ms GOST28147 20ms 20ms 20ms 30ms 20ms 30ms 50ms 30ms 20ms 20ms - - - - - - - - 60ms 40ms CHACHA20 10ms 0ms 0ms 20ms GOST28147_MESH 30ms 20ms 40ms 20ms 20ms 50ms 40ms 20ms 60ms 40ms - - - - - - - - 40ms 70ms SM4 20ms 10ms 30ms 10ms 50ms 30ms 10ms 30ms 0ms 30ms 30ms 20ms 50ms 30ms 10ms 20ms 10ms 10ms 30ms 30ms Algorithm generate 10*priv 10*public ------------------------------------------------ RSA 1024 bit 30ms 20ms 0ms RSA 2048 bit 430ms 110ms 0ms RSA 3072 bit 3250ms 330ms 0ms RSA 4096 bit 5050ms 690ms 0ms ELG 1024 bit - 140ms 70ms ELG 2048 bit - 750ms 360ms ELG 3072 bit - 2560ms 1310ms DSA 1024/160 - 10ms 10ms DSA 2048/224 - 20ms 60ms DSA 3072/256 - 80ms 70ms ECDSA 192 bit 10ms 30ms 40ms ECDSA 224 bit 10ms 50ms 40ms ECDSA 256 bit 20ms 50ms 40ms ECDSA 384 bit 20ms 90ms 90ms ECDSA 521 bit 70ms 230ms 240ms EdDSA Ed25519 10ms 0ms 30ms EdDSA Ed448 0ms 50ms 60ms GOST 256 bit 10ms 40ms 40ms GOST 512 bit 50ms 190ms 230ms powm 10ms 30ms 100ms random 10ms 10ms DURATION: 176 END: /usr/lib/libgcrypt/ptest 2023-03-24T11:04 STOP: ptest-runner PASS: benchmark SKIP: hashtest-256g 28 tests run, 28 succeeded, 0 failed, 1 skipped. testdrv: All tests completed in 0ms. Errors: 0 TOTAL: 1 FAIL: 0 DEBUG: [Command returned '0' after 176.59 seconds] DEBUG: Command: ptest-runner -t 450 -d "/usr/lib" Status: 0 Output: START: ptest-runner 2023-03-24T11:01 BEGIN: /usr/lib/libgcrypt/ptest version:1.10.1-unknown:10a01:1.46-unknown:12e00: cc:120200:gcc:12.2.0: ciphers:arcfour:blowfish:cast5:des:aes:twofish:serpent:rfc2268:seed:camellia:idea:salsa20:gost28147:chacha20:sm4: pubkeys:dsa:elgamal:rsa:ecc: digests:crc:gostr3411-94::md4:md5:rmd160:sha1:sha256:sha512:sha3:tiger:whirlpool:stribog:blake2:sm3: rnd-mod:getentropy: cpu-arch:: mpi-asm:generic/mpih-add1.c:generic/mpih-sub1.c:generic/mpih-mul1.c:generic/mpih-mul2.c:generic/mpih-mul3.c:generic/mpih-lshift.c:generic/mpih-rshift.c: hwflist: fips-mode:n::: rng-type:standard:1:3030000:2: compliance::: PASS: version PASS: t-secmem PASS: mpitests PASS: t-sexp PASS: t-convert PASS: t-mpi-bit PASS: t-mpi-point PASS: curves PASS: t-lock PASS: prime PASS: basic PASS: basic-disable-all-hwf PASS: keygen PASS: pubkey PASS: hmac PASS: hashtest PASS: t-kdf PASS: keygrip PASS: fips186-dsa PASS: aeswrap PASS: pkcs1v2 PASS: random PASS: dsa-rfc6979 t-ed25519: 256 of 1026 tests done t-ed25519: 512 of 1026 tests done t-ed25519: 768 of 1026 tests done t-ed25519: 1024 of 1026 tests done t-ed25519: 1026 tests done PASS: t-ed25519 t-cv25519: 18 tests done PASS: t-cv25519 t-x448: 9 tests done PASS: t-x448 t-ed448: 11 tests done PASS: t-ed448 Note: benchmark running in quick regression test mode. MD5 0ms 0ms 40ms 10ms 0ms SHA1 0ms 10ms 30ms 10ms 0ms RIPEMD160 0ms 10ms 30ms 10ms 0ms TIGER192 10ms 0ms 40ms 10ms 0ms SHA256 0ms 10ms 30ms 20ms 0ms SHA384 10ms 0ms 30ms 10ms 0ms SHA512 10ms 0ms 30ms 10ms 0ms SHA224 10ms 10ms 40ms 10ms 10ms MD4 0ms 0ms 30ms 0ms 0ms CRC32 10ms 0ms 10ms 10ms 0ms CRC32RFC1510 0ms 0ms 10ms 10ms 0ms CRC24RFC2440 0ms 0ms 10ms 10ms 0ms WHIRLPOOL 20ms 10ms 40ms 20ms 10ms TIGER 10ms 0ms 30ms 10ms 0ms TIGER2 0ms 10ms 20ms 10ms 0ms GOSTR3411_94 30ms 40ms 60ms 50ms 30ms STRIBOG256 20ms 20ms 40ms 20ms 30ms STRIBOG512 20ms 20ms 40ms 20ms 20ms GOSTR3411_CP 30ms 30ms 50ms 30ms 30ms SHA3-224 0ms 0ms 40ms 10ms 0ms SHA3-256 0ms 10ms 40ms 10ms 0ms SHA3-384 0ms 10ms 40ms 10ms 10ms SHA3-512 10ms 10ms 40ms 10ms 10ms SHAKE128 0ms 10ms 30ms 10ms SHAKE256 10ms 0ms 40ms 0ms BLAKE2B_512 10ms 0ms 20ms 10ms 0ms BLAKE2B_384 0ms 10ms 20ms 10ms 0ms BLAKE2B_256 0ms 10ms 20ms 10ms 0ms BLAKE2B_160 0ms 10ms 30ms 10ms 0ms BLAKE2S_256 0ms 10ms 20ms 10ms 0ms BLAKE2S_224 0ms 10ms 30ms 0ms 10ms BLAKE2S_160 0ms 10ms 20ms 10ms 0ms BLAKE2S_128 10ms 0ms 30ms 10ms 0ms SM3 10ms 10ms 40ms 10ms 0ms SHA512_256 10ms 0ms 40ms 0ms 10ms SHA512_224 0ms 10ms 30ms 10ms 0ms GOST28147_IMIT 10ms 10ms 10ms HMAC_SHA256 10ms 10ms 10ms HMAC_SHA224 10ms 0ms 10ms HMAC_SHA512 10ms 0ms 10ms HMAC_SHA384 0ms 10ms 10ms HMAC_SHA1 10ms 10ms 0ms HMAC_MD5 10ms 0ms 10ms HMAC_MD4 10ms 0ms 0ms HMAC_RIPEMD160 30ms 0ms 10ms HMAC_TIGER 0ms 10ms 10ms HMAC_WHIRLPOOL 10ms 40ms 30ms HMAC_GOSTR3411_94 70ms 30ms 50ms HMAC_STRIBOG256 20ms 20ms 50ms HMAC_STRIBOG512 40ms 20ms 30ms HMAC_SHA3_224 0ms 10ms 10ms HMAC_SHA3_256 10ms 20ms 10ms HMAC_SHA3_384 20ms 10ms 10ms HMAC_SHA3_512 10ms 20ms 20ms HMAC_GOSTR3411_CP 40ms 40ms 50ms HMAC_BLAKE2B_512 10ms 0ms 0ms HMAC_BLAKE2B_384 20ms 0ms 10ms HMAC_BLAKE2B_256 0ms 10ms 0ms HMAC_BLAKE2B_160 0ms 0ms 10ms HMAC_BLAKE2S_256 0ms 10ms 0ms HMAC_BLAKE2S_224 10ms 0ms 10ms HMAC_BLAKE2S_160 0ms 20ms 0ms HMAC_BLAKE2S_128 10ms 0ms 10ms HMAC_SM3 0ms 10ms 10ms HMAC_SHA512_256 10ms 0ms 10ms HMAC_SHA512_224 0ms 10ms 10ms CMAC_AES 10ms 10ms 10ms CMAC_3DES 40ms 40ms 50ms CMAC_CAMELLIA 0ms 10ms 20ms CMAC_CAST5 10ms 10ms 20ms CMAC_BLOWFISH 10ms 10ms 20ms CMAC_TWOFISH 10ms 0ms 20ms CMAC_SERPENT 20ms 10ms 20ms CMAC_SEED 20ms 10ms 30ms CMAC_RFC2268 40ms 20ms 30ms CMAC_IDEA 20ms 20ms 20ms CMAC_GOST28147 40ms 50ms 30ms CMAC_SM4 20ms 20ms 20ms GMAC_AES 0ms 10ms 10ms GMAC_CAMELLIA 0ms 10ms 10ms GMAC_TWOFISH 0ms 10ms 10ms GMAC_SERPENT 0ms 10ms 10ms GMAC_SEED 0ms 10ms 10ms POLY1305 0ms 0ms 10ms POLY1305_AES 0ms 0ms 0ms POLY1305_CAMELLIA 0ms 0ms 10ms POLY1305_TWOFISH 0ms 0ms 0ms POLY1305_SERPENT 10ms 0ms 0ms POLY1305_SEED 0ms 0ms 0ms ECB/Stream CBC/Poly1305 CFB OFB CTR XTS CCM GCM OCB EAX --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- IDEA 20ms 30ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms - - - - - - - - 30ms 40ms 3DES 40ms 40ms 40ms 50ms 40ms 40ms 40ms 50ms 40ms 40ms - - - - - - - - 80ms 90ms CAST5 10ms 20ms 10ms 0ms 20ms 0ms 20ms 10ms 10ms 0ms - - - - - - - - 20ms 20ms BLOWFISH 10ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 20ms 0ms - - - - - - - - 20ms 10ms AES 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms AES192 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 30ms 20ms AES256 20ms 20ms 10ms 20ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 10ms 20ms 30ms 20ms 20ms 10ms 20ms 20ms 30ms TWOFISH 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 10ms 20ms 10ms ARCFOUR 10ms 0ms DES 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms - - - - - - - - 30ms 40ms TWOFISH128 10ms 0ms 20ms 0ms 20ms 0ms 10ms 10ms 10ms 10ms 10ms 0ms 20ms 20ms 20ms 20ms 10ms 10ms 20ms 10ms SERPENT128 20ms 10ms 20ms 20ms 30ms 10ms 20ms 50ms 40ms 20ms 10ms 20ms 40ms 50ms 30ms 30ms 20ms 40ms 30ms 40ms SERPENT192 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 30ms 20ms 70ms 40ms 20ms 40ms 10ms 20ms 40ms 50ms SERPENT256 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 20ms 10ms 20ms 20ms 30ms 40ms 20ms 20ms 20ms 10ms 40ms 30ms RFC2268_40 30ms 20ms 20ms 20ms 30ms 30ms 20ms 30ms 30ms 30ms - - - - - - - - 50ms 60ms RFC2268_128 20ms 20ms 30ms 20ms 20ms 30ms 30ms 20ms 40ms 20ms - - - - - - - - 50ms 80ms SEED 30ms 20ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 20ms 20ms 40ms 40ms CAMELLIA128 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 20ms 10ms 10ms 20ms 20ms 20ms CAMELLIA192 20ms 20ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 30ms 30ms 10ms 20ms 10ms 10ms 30ms 20ms CAMELLIA256 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 20ms 30ms SALSA20 0ms 0ms SALSA20R12 10ms 0ms GOST28147 20ms 20ms 20ms 30ms 20ms 30ms 50ms 30ms 20ms 20ms - - - - - - - - 60ms 40ms CHACHA20 10ms 0ms 0ms 20ms GOST28147_MESH 30ms 20ms 40ms 20ms 20ms 50ms 40ms 20ms 60ms 40ms - - - - - - - - 40ms 70ms SM4 20ms 10ms 30ms 10ms 50ms 30ms 10ms 30ms 0ms 30ms 30ms 20ms 50ms 30ms 10ms 20ms 10ms 10ms 30ms 30ms Algorithm generate 10*priv 10*public ------------------------------------------------ RSA 1024 bit 30ms 20ms 0ms RSA 2048 bit 430ms 110ms 0ms RSA 3072 bit 3250ms 330ms 0ms RSA 4096 bit 5050ms 690ms 0ms ELG 1024 bit - 140ms 70ms ELG 2048 bit - 750ms 360ms ELG 3072 bit - 2560ms 1310ms DSA 1024/160 - 10ms 10ms DSA 2048/224 - 20ms 60ms DSA 3072/256 - 80ms 70ms ECDSA 192 bit 10ms 30ms 40ms ECDSA 224 bit 10ms 50ms 40ms ECDSA 256 bit 20ms 50ms 40ms ECDSA 384 bit 20ms 90ms 90ms ECDSA 521 bit 70ms 230ms 240ms EdDSA Ed25519 10ms 0ms 30ms EdDSA Ed448 0ms 50ms 60ms GOST 256 bit 10ms 40ms 40ms GOST 512 bit 50ms 190ms 230ms powm 10ms 30ms 100ms random 10ms 10ms DURATION: 176 END: /usr/lib/libgcrypt/ptest 2023-03-24T11:04 STOP: ptest-runner PASS: benchmark SKIP: hashtest-256g 28 tests run, 28 succeeded, 0 failed, 1 skipped. testdrv: All tests completed in 0ms. Errors: 0 TOTAL: 1 FAIL: 0 DEBUG: [Running]$ ssh -l root -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR 192.168.7.28 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg | grep "Killed process" DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.20 seconds] DEBUG: Command: dmesg | grep "Killed process" Status: 1 Output: NOTE: ... unexpected success NOTE: test_ptestrunner_expectsuccess (ptest.PtestRunnerTest) DEBUG: Checking if at least one of ptest-runner is installed DEBUG: Checking if ptest is in DISTRO_FEATURES or IMAGE_FEATURES NOTE: ... skipped 'Cannot run ptests without @expectedFailure as ptests are expected to fail' Cannot run ptests without @expectedFailure as ptests are expected to fail NOTE: ---------------------------------------------------------------------- NOTE: Ran 5 tests in 184.289s NOTE: OK NOTE: (skipped=1, unexpected successes=1) DEBUG: Stopping logging thread DEBUG: Stop event received DEBUG: Tearing down logging thread DEBUG: Sending SIGTERM to runqemu Output from runqemu: runqemu - INFO - Received signal: 15 runqemu - INFO - Cleaning up runqemu - INFO - Host uptime: 321632.21 runqemu - INFO - Removing /home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.132687 tput: No value for $TERM and no -T specified RESULTS: RESULTS - parselogs.ParseLogsTest.test_parselogs: PASSED (5.52s) RESULTS - ping.PingTest.test_ping: PASSED (0.15s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectfail: PASSED (177.02s) RESULTS - ssh.SSHTest.test_ssh: PASSED (1.21s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectsuccess: SKIPPED (0.00s) SUMMARY: core-image-ptest-libgcrypt () - Ran 5 tests in 184.290s core-image-ptest-libgcrypt - OK - All required tests passed (successes=3, skipped=1, failures=0, errors=0) /home/pokybuild/yocto-worker/qemuarm64-ptest/build/meta/lib/oeqa/utils/qemurunner.py:486: ResourceWarning: unclosed self.server_socket = qemusock ResourceWarning: Enable tracemalloc to get the object allocation traceback DEBUG: Python function do_testimage finished