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', 'zlib-native', 'libxml2-native', 'python3-native', 'curl-native', 'file-native', 'openssl-native', 'xz-native', 'glib-2.0-native', 'expat-native', 'rpm-native', 'cmake-native', 'sqlite3-native', 'libtool-native', 'flex-native', 'libtirpc-native', 'libsdl2-native', 'pixman-native', 'dtc-native', 'libslirp-native', 'libepoxy-native', 'virglrenderer-native', 'alsa-lib-native', 'gettext-minimal-native', 'texinfo-dummy-native', 'libcomps-native', 'librepo-native', 'libdnf-native', 'python3-iniparse-native', 'util-linux-libuuid-native', 'ncurses-native', 'libffi-native', 'readline-native', 'bzip2-native', 'libnsl2-native', 'gdbm-native', 'perl-native', 'libpcre2-native', 'util-linux-native', 'gettext-native', 'libgcrypt-native', 'lua-native', 'elfutils-native', 'zstd-native', 'popt-native', 'm4-native', 'libxrandr-native', 'libxrender-native', 'libxext-native', 'mesa-native', 'libx11-native', 'libdrm-native', 'libcheck-native', 'attr-native', 'gpgme-native', 'libmodulemd-native', 'json-c-native', 'libsolv-native', 'gobject-introspection-native', 'swig-native', 'python3-six-native', 'python3-installer-native', 'python3-setuptools-native', 'python3-build-native', 'python3-wheel-native', 'make-native', 'libcap-ng-native', 'libgpg-error-native', 'libcap-native', 'libarchive-native', 'libmicrohttpd-native', 'gnu-config-native', 'xorgproto-native', 'util-macros-native', 'libxxf86vm-native', 'xrandr-native', 'wayland-native', 'libxdamage-native', 'libxfixes-native', 'chrpath-native', 'makedepend-native', 'wayland-protocols-native', 'python3-mako-native', 'llvm-native', 'libxshmfence-native', 'xtrans-native', 'libxcb-native', 'libpthread-stubs-native', 'libpciaccess-native', 'libassuan-native', 'libyaml-native', 'python3-flit-core-native', 'python3-pyproject-hooks-native', 'python3-packaging-native', 'gnutls-native', 'python3-markupsafe-native', 'python3-pygments-native', 'libedit-native', 'libxau-native', 'libxdmcp-native', 'xcb-proto-native', 'unzip-native', 'gmp-native', 'nettle-native', 'libidn2-native', 'libunistring-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/.jfku523x DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:59291 DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:55737 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=59291:55737 bootparams=" printk.time=1" qemuparams="-pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_193825 -S -qmp unix:./.8ijcln9e,server,wait -qmp unix:./.jfku523x,server,nowait" DEBUG: runqemu started, pid is 193897 DEBUG: waiting at most 300 seconds for qemu pid (03/19/23 17:56:44) DEBUG: QMP Initializing to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.8ijcln9e DEBUG: QMP Connecting to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.8ijcln9e QMP connected to QEMU at 03/19/23 17:56:45 and took 1.1660797595977783 seconds QMP released QEMU at 03/19/23 17:56:46 and took 0.31342577934265137 seconds from connect DEBUG: qemu started in 1.4765141010284424 seconds - qemu procces pid is 193923 (03/19/23 17:56:46) 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:1e -netdev tap,id=net0,ifname=tap14,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.193900,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=59291,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:55737 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_193825 -S -qmp unix:./.8ijcln9e,server,wait -qmp unix:./.jfku523x,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.30::192.168.7.29:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1 DEBUG: Target IP: 192.168.7.30 DEBUG: Server IP: 192.168.7.29 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 - Acquiring lockfile /tmp/qemu-tap-locks/tap13.lock failed: [Errno 11] Resource temporarily unavailable runqemu - INFO - Using preconfigured tap device tap14 runqemu - INFO - If this is not intended, touch /tmp/qemu-tap-locks/tap14.skip to make runqemu skip tap14. runqemu - INFO - Network configuration: ip=192.168.7.30::192.168.7.29:255.255.255.0::eth0:off:8.8.8.8 runqemu - INFO - Copying rootfs to /home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.193900 runqemu - INFO - Copy done in 0.41594481468200684 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:1e -netdev tap,id=net0,ifname=tap14,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.193900,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=59291,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:55737 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_193825 -S -qmp unix:./.8ijcln9e,server,wait -qmp unix:./.jfku523x,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.30::192.168.7.29:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1' runqemu - INFO - Host uptime: 522449.57 DEBUG: Waiting at most 1500 seconds for login banner (03/19/23 17:56:46) DEBUG: Connection from 127.0.0.1:36024 DEBUG: Reached login banner in 3.5114409923553467 seconds (03/19/23 17:56:49, 1679248609.8311718) 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 dropbear, openssh-sshd 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -a DEBUG: Waiting for process output: time: 1679248613.0120163, endtime: 1679248913.0010068 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: 1679248613.3644025, endtime: 1679248913.3643992 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.57 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /etc/controllerimage DEBUG: Waiting for process output: time: 1679248613.5785935, endtime: 1679248913.566782 DEBUG: Partial data from SSH call: cat: can't open '/etc/controllerimage': No such file or directory DEBUG: Waiting for process output: time: 1679248613.9272323, endtime: 1679248913.9272292 DEBUG: Data from SSH call: cat: can't open '/etc/controllerimage': No such file or directory DEBUG: [Command returned '1' after 0.56 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; which LSB_Test.sh DEBUG: Waiting for process output: time: 1679248614.1402376, endtime: 1679248914.1304975 DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.36 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg > /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1679248614.5014784, endtime: 1679248914.490525 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.36 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/ DEBUG: Waiting for process output: time: 1679248614.864221, endtime: 1679248914.8545816 DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.35 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -d /var/log/ DEBUG: Waiting for process output: time: 1679248615.2203717, endtime: 1679248915.2096753 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.36 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; find /var/log//*.log -maxdepth 1 -type f DEBUG: Waiting for process output: time: 1679248615.5788653, endtime: 1679248915.5693142 DEBUG: Partial data from SSH call: /var/log//postinstall.log DEBUG: Waiting for process output: time: 1679248615.91969, endtime: 1679248915.9196868 DEBUG: Data from SSH call: /var/log//postinstall.log DEBUG: [Command returned '0' after 0.55 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/dmesg DEBUG: Waiting for process output: time: 1679248616.132829, endtime: 1679248916.1220615 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.36 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1679248616.4907844, endtime: 1679248916.480552 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.36 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.30:/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.17 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.30:/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.17 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.30:/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.16 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.30 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: 1679248617.4061544, endtime: 1679248917.3957493 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.36 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.30 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: 1679248617.765175, endtime: 1679248917.7554648 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.37 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /proc/cpuinfo | grep "processor" | wc -l DEBUG: Waiting for process output: time: 1679248618.14141, endtime: 1679248918.1300726 DEBUG: Partial data from SSH call: 4 DEBUG: Waiting for process output: time: 1679248618.4888537, endtime: 1679248918.4888508 DEBUG: Data from SSH call: 4 DEBUG: [Command returned '0' after 0.56 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -m DEBUG: Waiting for process output: time: 1679248618.7029917, endtime: 1679248918.6912918 DEBUG: Partial data from SSH call: aarch64 DEBUG: Waiting for process output: time: 1679248619.0475433, endtime: 1679248919.0475404 DEBUG: Data from SSH call: aarch64 DEBUG: [Command returned '0' after 0.56 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.30 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.15 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.30 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-19T17:56 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 20ms 10ms 0ms SHA1 0ms 10ms 30ms 0ms 0ms RIPEMD160 10ms 0ms 30ms 10ms 0ms TIGER192 0ms 10ms 20ms 10ms 0ms SHA256 0ms 10ms 30ms 10ms 10ms SHA384 0ms 10ms 20ms 10ms 0ms SHA512 10ms 0ms 30ms 10ms 0ms SHA224 10ms 10ms 30ms 10ms 0ms MD4 0ms 10ms 20ms 0ms 10ms CRC32 0ms 0ms 10ms 0ms 0ms CRC32RFC1510 0ms 10ms 10ms 0ms 0ms CRC24RFC2440 10ms 0ms 10ms 0ms 10ms WHIRLPOOL 10ms 10ms 40ms 10ms 20ms TIGER 0ms 0ms 20ms 10ms 0ms TIGER2 0ms 0ms 30ms 10ms 0ms GOSTR3411_94 30ms 30ms 50ms 30ms 30ms STRIBOG256 20ms 10ms 40ms 20ms 20ms STRIBOG512 10ms 20ms 40ms 10ms 20ms GOSTR3411_CP 30ms 30ms 50ms 40ms 30ms SHA3-224 0ms 10ms 30ms 10ms 0ms SHA3-256 10ms 0ms 40ms 0ms 10ms SHA3-384 0ms 10ms 40ms 10ms 0ms SHA3-512 10ms 10ms 40ms 10ms 10ms SHAKE128 0ms 10ms 30ms 10ms SHAKE256 0ms 10ms 30ms 10ms BLAKE2B_512 0ms 10ms 20ms 0ms 10ms BLAKE2B_384 0ms 0ms 20ms 10ms 0ms BLAKE2B_256 0ms 0ms 30ms 0ms 0ms BLAKE2B_160 0ms 0ms 20ms 10ms 0ms BLAKE2S_256 0ms 10ms 20ms 10ms 0ms BLAKE2S_224 0ms 10ms 20ms 10ms 0ms BLAKE2S_160 10ms 0ms 20ms 10ms 0ms BLAKE2S_128 10ms 0ms 30ms 0ms 10ms SM3 0ms 10ms 30ms 10ms 0ms SHA512_256 10ms 0ms 30ms 10ms 0ms SHA512_224 0ms 10ms 30ms 0ms 10ms GOST28147_IMIT 10ms 10ms 10ms HMAC_SHA256 10ms 10ms 10ms HMAC_SHA224 0ms 10ms 10ms HMAC_SHA512 0ms 10ms 0ms HMAC_SHA384 10ms 0ms 10ms HMAC_SHA1 0ms 10ms 0ms HMAC_MD5 10ms 0ms 0ms HMAC_MD4 10ms 0ms 0ms HMAC_RIPEMD160 10ms 0ms 10ms HMAC_TIGER 0ms 0ms 10ms HMAC_WHIRLPOOL 10ms 10ms 20ms HMAC_GOSTR3411_94 30ms 30ms 40ms HMAC_STRIBOG256 10ms 20ms 20ms HMAC_STRIBOG512 10ms 20ms 20ms HMAC_SHA3_224 0ms 10ms 10ms HMAC_SHA3_256 0ms 10ms 0ms HMAC_SHA3_384 10ms 10ms 10ms HMAC_SHA3_512 10ms 0ms 20ms HMAC_GOSTR3411_CP 30ms 30ms 30ms HMAC_BLAKE2B_512 0ms 10ms 0ms HMAC_BLAKE2B_384 0ms 10ms 0ms HMAC_BLAKE2B_256 0ms 10ms 0ms HMAC_BLAKE2B_160 0ms 10ms 0ms HMAC_BLAKE2S_256 0ms 10ms 0ms HMAC_BLAKE2S_224 10ms 0ms 10ms HMAC_BLAKE2S_160 0ms 0ms 10ms HMAC_BLAKE2S_128 0ms 10ms 0ms HMAC_SM3 10ms 10ms 10ms HMAC_SHA512_256 0ms 0ms 10ms HMAC_SHA512_224 10ms 0ms 10ms CMAC_AES 10ms 10ms 10ms CMAC_3DES 40ms 30ms 50ms CMAC_CAMELLIA 10ms 0ms 20ms CMAC_CAST5 10ms 10ms 20ms CMAC_BLOWFISH 10ms 10ms 10ms CMAC_TWOFISH 10ms 10ms 10ms CMAC_SERPENT 20ms 10ms 20ms CMAC_SEED 10ms 20ms 20ms CMAC_RFC2268 20ms 30ms 30ms CMAC_IDEA 10ms 20ms 20ms CMAC_GOST28147 30ms 20ms 20ms CMAC_SM4 20ms 20ms 20ms GMAC_AES 0ms 10ms 10ms GMAC_CAMELLIA 0ms 10ms 0ms GMAC_TWOFISH 10ms 0ms 10ms GMAC_SERPENT 10ms 0ms 10ms GMAC_SEED 10ms 0ms 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 10ms ECB/Stream CBC/Poly1305 CFB OFB CTR XTS CCM GCM OCB EAX --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- IDEA 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms - - - - - - - - 30ms 30ms 3DES 40ms 40ms 40ms 40ms 40ms 30ms 40ms 40ms 40ms 40ms - - - - - - - - 80ms 80ms CAST5 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms - - - - - - - - 20ms 20ms BLOWFISH 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 0ms 10ms - - - - - - - - 10ms 20ms AES 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms AES192 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 20ms 20ms AES256 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 20ms 20ms 10ms 10ms 20ms 20ms 20ms TWOFISH 10ms 10ms 0ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 10ms 10ms 10ms 10ms 20ms ARCFOUR 0ms 10ms DES 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms - - - - - - - - 30ms 30ms TWOFISH128 10ms 0ms 10ms 10ms 10ms 0ms 0ms 10ms 10ms 0ms 10ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 10ms SERPENT128 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 20ms 10ms 30ms 40ms SERPENT192 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 10ms 20ms 30ms 30ms SERPENT256 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms 10ms 30ms 40ms 20ms 20ms 10ms 20ms 30ms 30ms RFC2268_40 30ms 20ms 20ms 20ms 30ms 30ms 20ms 30ms 20ms 30ms - - - - - - - - 50ms 50ms RFC2268_128 30ms 20ms 30ms 10ms 30ms 30ms 20ms 30ms 20ms 30ms - - - - - - - - 50ms 60ms SEED 10ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 30ms 30ms 20ms 20ms 10ms 20ms 30ms 30ms CAMELLIA128 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms CAMELLIA192 10ms 10ms 10ms 20ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 30ms 20ms 10ms 20ms 10ms 10ms 30ms 20ms CAMELLIA256 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 30ms 10ms 20ms 10ms 10ms 20ms 30ms SALSA20 0ms 0ms SALSA20R12 10ms 0ms GOST28147 20ms 20ms 20ms 30ms 20ms 20ms 30ms 20ms 20ms 20ms - - - - - - - - 50ms 50ms CHACHA20 0ms 0ms 10ms 0ms GOST28147_MESH 20ms 20ms 30ms 20ms 20ms 20ms 30ms 20ms 20ms 20ms - - - - - - - - 50ms 40ms SM4 20ms 10ms 20ms 10ms 20ms 10ms 10ms 20ms 10ms 10ms 20ms 20ms 20ms 30ms 20ms 10ms 10ms 10ms 30ms 30ms Algorithm generate 10*priv 10*public ------------------------------------------------ RSA 1024 bit 60ms 20ms 0ms RSA 2048 bit 190ms 110ms 0ms RSA 3072 bit 2450ms 260ms 10ms RSA 4096 bit 6120ms 520ms 0ms ELG 1024 bit - 130ms 60ms ELG 2048 bit - 680ms 310ms ELG 3072 bit - 1860ms 850ms DSA 1024/160 - 10ms 10ms DSA 2048/224 - 10ms 30ms DSA 3072/256 - 40ms 50ms ECDSA 192 bit 10ms 20ms 30ms ECDSA 224 bit 10ms 40ms 50ms ECDSA 256 bit 10ms 30ms 40ms ECDSA 384 bit 30ms 70ms 90ms ECDSA 521 bit 50ms 170ms 180ms EdDSA Ed25519 10ms 0ms 20ms EdDSA Ed448 0ms 30ms 60ms GOST 256 bit 10ms 40ms 40ms GOST 512 bit 50ms 150ms 180ms powm 10ms 10ms 50ms random 0ms 0ms PASS: benchmark SKIP: hashtest-256g 28 tests run, 28 succeeded, 0 failed, 1 skipped. testdrv: All tests completed in 0ms. Errors: 0 DURATION: 106 END: /usr/lib/libgcrypt/ptest 2023-03-19T17:58 STOP: ptest-runner TOTAL: 1 FAIL: 0 DEBUG: [Command returned '0' after 106.03 seconds] DEBUG: Command: ptest-runner -t 450 -d "/usr/lib" Status: 0 Output: START: ptest-runner 2023-03-19T17:56 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 20ms 10ms 0ms SHA1 0ms 10ms 30ms 0ms 0ms RIPEMD160 10ms 0ms 30ms 10ms 0ms TIGER192 0ms 10ms 20ms 10ms 0ms SHA256 0ms 10ms 30ms 10ms 10ms SHA384 0ms 10ms 20ms 10ms 0ms SHA512 10ms 0ms 30ms 10ms 0ms SHA224 10ms 10ms 30ms 10ms 0ms MD4 0ms 10ms 20ms 0ms 10ms CRC32 0ms 0ms 10ms 0ms 0ms CRC32RFC1510 0ms 10ms 10ms 0ms 0ms CRC24RFC2440 10ms 0ms 10ms 0ms 10ms WHIRLPOOL 10ms 10ms 40ms 10ms 20ms TIGER 0ms 0ms 20ms 10ms 0ms TIGER2 0ms 0ms 30ms 10ms 0ms GOSTR3411_94 30ms 30ms 50ms 30ms 30ms STRIBOG256 20ms 10ms 40ms 20ms 20ms STRIBOG512 10ms 20ms 40ms 10ms 20ms GOSTR3411_CP 30ms 30ms 50ms 40ms 30ms SHA3-224 0ms 10ms 30ms 10ms 0ms SHA3-256 10ms 0ms 40ms 0ms 10ms SHA3-384 0ms 10ms 40ms 10ms 0ms SHA3-512 10ms 10ms 40ms 10ms 10ms SHAKE128 0ms 10ms 30ms 10ms SHAKE256 0ms 10ms 30ms 10ms BLAKE2B_512 0ms 10ms 20ms 0ms 10ms BLAKE2B_384 0ms 0ms 20ms 10ms 0ms BLAKE2B_256 0ms 0ms 30ms 0ms 0ms BLAKE2B_160 0ms 0ms 20ms 10ms 0ms BLAKE2S_256 0ms 10ms 20ms 10ms 0ms BLAKE2S_224 0ms 10ms 20ms 10ms 0ms BLAKE2S_160 10ms 0ms 20ms 10ms 0ms BLAKE2S_128 10ms 0ms 30ms 0ms 10ms SM3 0ms 10ms 30ms 10ms 0ms SHA512_256 10ms 0ms 30ms 10ms 0ms SHA512_224 0ms 10ms 30ms 0ms 10ms GOST28147_IMIT 10ms 10ms 10ms HMAC_SHA256 10ms 10ms 10ms HMAC_SHA224 0ms 10ms 10ms HMAC_SHA512 0ms 10ms 0ms HMAC_SHA384 10ms 0ms 10ms HMAC_SHA1 0ms 10ms 0ms HMAC_MD5 10ms 0ms 0ms HMAC_MD4 10ms 0ms 0ms HMAC_RIPEMD160 10ms 0ms 10ms HMAC_TIGER 0ms 0ms 10ms HMAC_WHIRLPOOL 10ms 10ms 20ms HMAC_GOSTR3411_94 30ms 30ms 40ms HMAC_STRIBOG256 10ms 20ms 20ms HMAC_STRIBOG512 10ms 20ms 20ms HMAC_SHA3_224 0ms 10ms 10ms HMAC_SHA3_256 0ms 10ms 0ms HMAC_SHA3_384 10ms 10ms 10ms HMAC_SHA3_512 10ms 0ms 20ms HMAC_GOSTR3411_CP 30ms 30ms 30ms HMAC_BLAKE2B_512 0ms 10ms 0ms HMAC_BLAKE2B_384 0ms 10ms 0ms HMAC_BLAKE2B_256 0ms 10ms 0ms HMAC_BLAKE2B_160 0ms 10ms 0ms HMAC_BLAKE2S_256 0ms 10ms 0ms HMAC_BLAKE2S_224 10ms 0ms 10ms HMAC_BLAKE2S_160 0ms 0ms 10ms HMAC_BLAKE2S_128 0ms 10ms 0ms HMAC_SM3 10ms 10ms 10ms HMAC_SHA512_256 0ms 0ms 10ms HMAC_SHA512_224 10ms 0ms 10ms CMAC_AES 10ms 10ms 10ms CMAC_3DES 40ms 30ms 50ms CMAC_CAMELLIA 10ms 0ms 20ms CMAC_CAST5 10ms 10ms 20ms CMAC_BLOWFISH 10ms 10ms 10ms CMAC_TWOFISH 10ms 10ms 10ms CMAC_SERPENT 20ms 10ms 20ms CMAC_SEED 10ms 20ms 20ms CMAC_RFC2268 20ms 30ms 30ms CMAC_IDEA 10ms 20ms 20ms CMAC_GOST28147 30ms 20ms 20ms CMAC_SM4 20ms 20ms 20ms GMAC_AES 0ms 10ms 10ms GMAC_CAMELLIA 0ms 10ms 0ms GMAC_TWOFISH 10ms 0ms 10ms GMAC_SERPENT 10ms 0ms 10ms GMAC_SEED 10ms 0ms 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 10ms ECB/Stream CBC/Poly1305 CFB OFB CTR XTS CCM GCM OCB EAX --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- --------------- IDEA 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms - - - - - - - - 30ms 30ms 3DES 40ms 40ms 40ms 40ms 40ms 30ms 40ms 40ms 40ms 40ms - - - - - - - - 80ms 80ms CAST5 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms - - - - - - - - 20ms 20ms BLOWFISH 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 0ms 10ms - - - - - - - - 10ms 20ms AES 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms AES192 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 10ms 20ms 10ms 10ms 20ms 20ms AES256 10ms 10ms 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 20ms 20ms 20ms 10ms 10ms 20ms 20ms 20ms TWOFISH 10ms 10ms 0ms 10ms 10ms 10ms 10ms 0ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 10ms 10ms 10ms 10ms 20ms ARCFOUR 0ms 10ms DES 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms - - - - - - - - 30ms 30ms TWOFISH128 10ms 0ms 10ms 10ms 10ms 0ms 0ms 10ms 10ms 0ms 10ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 10ms SERPENT128 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 20ms 10ms 30ms 40ms SERPENT192 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 40ms 30ms 20ms 20ms 10ms 20ms 30ms 30ms SERPENT256 20ms 10ms 20ms 10ms 20ms 20ms 10ms 20ms 10ms 20ms 20ms 10ms 30ms 40ms 20ms 20ms 10ms 20ms 30ms 30ms RFC2268_40 30ms 20ms 20ms 20ms 30ms 30ms 20ms 30ms 20ms 30ms - - - - - - - - 50ms 50ms RFC2268_128 30ms 20ms 30ms 10ms 30ms 30ms 20ms 30ms 20ms 30ms - - - - - - - - 50ms 60ms SEED 10ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 20ms 10ms 30ms 30ms 20ms 20ms 10ms 20ms 30ms 30ms CAMELLIA128 10ms 10ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 0ms 10ms 20ms 20ms 10ms 10ms 10ms 10ms 20ms 20ms CAMELLIA192 10ms 10ms 10ms 20ms 0ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 30ms 20ms 10ms 20ms 10ms 10ms 30ms 20ms CAMELLIA256 10ms 10ms 20ms 10ms 10ms 10ms 10ms 10ms 10ms 10ms 20ms 10ms 20ms 30ms 10ms 20ms 10ms 10ms 20ms 30ms SALSA20 0ms 0ms SALSA20R12 10ms 0ms GOST28147 20ms 20ms 20ms 30ms 20ms 20ms 30ms 20ms 20ms 20ms - - - - - - - - 50ms 50ms CHACHA20 0ms 0ms 10ms 0ms GOST28147_MESH 20ms 20ms 30ms 20ms 20ms 20ms 30ms 20ms 20ms 20ms - - - - - - - - 50ms 40ms SM4 20ms 10ms 20ms 10ms 20ms 10ms 10ms 20ms 10ms 10ms 20ms 20ms 20ms 30ms 20ms 10ms 10ms 10ms 30ms 30ms Algorithm generate 10*priv 10*public ------------------------------------------------ RSA 1024 bit 60ms 20ms 0ms RSA 2048 bit 190ms 110ms 0ms RSA 3072 bit 2450ms 260ms 10ms RSA 4096 bit 6120ms 520ms 0ms ELG 1024 bit - 130ms 60ms ELG 2048 bit - 680ms 310ms ELG 3072 bit - 1860ms 850ms DSA 1024/160 - 10ms 10ms DSA 2048/224 - 10ms 30ms DSA 3072/256 - 40ms 50ms ECDSA 192 bit 10ms 20ms 30ms ECDSA 224 bit 10ms 40ms 50ms ECDSA 256 bit 10ms 30ms 40ms ECDSA 384 bit 30ms 70ms 90ms ECDSA 521 bit 50ms 170ms 180ms EdDSA Ed25519 10ms 0ms 20ms EdDSA Ed448 0ms 30ms 60ms GOST 256 bit 10ms 40ms 40ms GOST 512 bit 50ms 150ms 180ms powm 10ms 10ms 50ms random 0ms 0ms PASS: benchmark SKIP: hashtest-256g 28 tests run, 28 succeeded, 0 failed, 1 skipped. testdrv: All tests completed in 0ms. Errors: 0 DURATION: 106 END: /usr/lib/libgcrypt/ptest 2023-03-19T17:58 STOP: ptest-runner 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.30 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg | grep "Killed process" DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.16 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 112.657s 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: 522574.75 runqemu - INFO - Removing /home/pokybuild/tmp/core-image-ptest-libgcrypt-qemuarm64.ext4.193900 tput: No value for $TERM and no -T specified RESULTS: RESULTS - parselogs.ParseLogsTest.test_parselogs: PASSED (4.76s) RESULTS - ping.PingTest.test_ping: PASSED (0.05s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectfail: PASSED (106.35s) RESULTS - ssh.SSHTest.test_ssh: PASSED (1.13s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectsuccess: SKIPPED (0.00s) SUMMARY: core-image-ptest-libgcrypt () - Ran 5 tests in 112.659s 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