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', 'alsa-lib-native', 'pixman-native', 'zlib-native', 'libslirp-native', 'virglrenderer-native', 'dtc-native', 'libepoxy-native', 'libsdl2-native', 'glib-2.0-native', 'xz-native', 'libtirpc-native', 'libtool-native', 'flex-native', 'openssl-native', 'file-native', 'expat-native', 'cmake-native', 'python3-native', 'sqlite3-native', 'rpm-native', 'libxml2-native', 'curl-native', 'gettext-minimal-native', 'texinfo-dummy-native', 'librepo-native', 'libcomps-native', 'libdnf-native', 'python3-iniparse-native', 'mesa-native', 'libdrm-native', 'libx11-native', 'libxrender-native', 'libxext-native', 'libxrandr-native', 'gettext-native', 'util-linux-native', 'libpcre2-native', 'libffi-native', 'm4-native', 'perl-native', 'bzip2-native', 'ncurses-native', 'zstd-native', 'gdbm-native', 'libnsl2-native', 'readline-native', 'util-linux-libuuid-native', 'libgcrypt-native', 'lua-native', 'popt-native', 'elfutils-native', 'attr-native', 'gpgme-native', 'libcheck-native', 'libsolv-native', 'libmodulemd-native', 'gobject-introspection-native', 'json-c-native', 'swig-native', 'python3-six-native', 'python3-wheel-native', 'python3-installer-native', 'python3-setuptools-native', 'python3-build-native', 'chrpath-native', 'llvm-native', 'libxxf86vm-native', 'libxshmfence-native', 'xrandr-native', 'python3-mako-native', 'xorgproto-native', 'libxdamage-native', 'libxfixes-native', 'wayland-protocols-native', 'makedepend-native', 'wayland-native', 'libpthread-stubs-native', 'libpciaccess-native', 'xtrans-native', 'util-macros-native', 'libxcb-native', 'libcap-ng-native', 'gnu-config-native', 'make-native', 'libcap-native', 'libgpg-error-native', 'libmicrohttpd-native', 'libarchive-native', 'libassuan-native', 'libyaml-native', 'python3-flit-core-native', 'python3-pyproject-hooks-native', 'python3-packaging-native', 'libedit-native', 'python3-markupsafe-native', 'python3-pygments-native', 'libxau-native', 'libxdmcp-native', 'xcb-proto-native', 'gnutls-native', 'unzip-native', 'libunistring-native', 'gmp-native', 'libidn2-native', 'nettle-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/.88hv_uvn DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:35765 DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:57089 DEBUG: launchcmd=runqemu snapshot kvm qemuarm64 /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/core-image-ptest-m4-qemuarm64.ext4 tcpserial=35765:57089 bootparams=" printk.time=1" qemuparams="-pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_670080 -S -qmp unix:./.ow28hwwb,server,wait -qmp unix:./.88hv_uvn,server,nowait" DEBUG: runqemu started, pid is 670665 DEBUG: waiting at most 300 seconds for qemu pid (04/06/23 11:19:29) DEBUG: QMP Initializing to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.ow28hwwb DEBUG: QMP Connecting to /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/.ow28hwwb QMP connected to QEMU at 04/06/23 11:19:30 and took 1.21 seconds QMP released QEMU at 04/06/23 11:19:31 and took 0.31 seconds from connect DEBUG: qemu started in 1.52 seconds - qemu procces pid is 670772 (04/06/23 11:19:31) 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:18 -netdev tap,id=net0,ifname=tap11,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-m4-qemuarm64.ext4.670670,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=35765,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:57089 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_670080 -S -qmp unix:./.ow28hwwb,server,wait -qmp unix:./.88hv_uvn,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.24::192.168.7.23:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1 DEBUG: Target IP: 192.168.7.24 DEBUG: Server IP: 192.168.7.23 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-m4-qemuarm64.ext4] CONFFILE: [/home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/deploy/images/qemuarm64/core-image-ptest-m4-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 - Using preconfigured tap device tap11 runqemu - INFO - If this is not intended, touch /tmp/qemu-tap-locks/tap11.skip to make runqemu skip tap11. runqemu - INFO - Network configuration: ip=192.168.7.24::192.168.7.23:255.255.255.0::eth0:off:8.8.8.8 runqemu - INFO - Copying rootfs to /home/pokybuild/tmp/core-image-ptest-m4-qemuarm64.ext4.670670 runqemu - INFO - Copy done in 0.5788657665252686 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:18 -netdev tap,id=net0,ifname=tap11,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-m4-qemuarm64.ext4.670670,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=35765,host=127.0.0.1 -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:57089 -pidfile /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/pidfile_670080 -S -qmp unix:./.ow28hwwb,server,wait -qmp unix:./.88hv_uvn,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.24::192.168.7.23:255.255.255.0::eth0:off:8.8.8.8 console=ttyAMA0 console=hvc0 printk.time=1' runqemu - INFO - Host uptime: 239607.96 DEBUG: Waiting at most 1500 seconds for login banner (04/06/23 11:19:31) DEBUG: Connection from 127.0.0.1:39224 DEBUG: Reached login banner in 4.56 seconds (04/06/23 11:19:35) DEBUG: Logged in 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -a DEBUG: Waiting for process output: time: 1680779978.8925836, endtime: 1680780278.8710878 DEBUG: Partial data from SSH call: Linux qemuarm64 6.1.20-yocto-standard #1 SMP PREEMPT Sat Mar 18 02:48:04 UTC 2023 aarch64 GNU/Linux DEBUG: Waiting for process output: time: 1680779979.266815, endtime: 1680780279.2668111 DEBUG: Data from SSH call: Linux qemuarm64 6.1.20-yocto-standard #1 SMP PREEMPT Sat Mar 18 02:48:04 UTC 2023 aarch64 GNU/Linux DEBUG: [Command returned '0' after 0.60 seconds] DEBUG: Command: uname -a Status: 0 Output: Linux qemuarm64 6.1.20-yocto-standard #1 SMP PREEMPT Sat Mar 18 02:48:04 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /etc/controllerimage DEBUG: Waiting for process output: time: 1680779979.4976778, endtime: 1680780279.4692607 DEBUG: Partial data from SSH call: cat: /etc/controllerimage: No such file or directory DEBUG: Waiting for process output: time: 1680779979.8615687, endtime: 1680780279.8615644 DEBUG: Data from SSH call: cat: /etc/controllerimage: No such file or directory DEBUG: [Command returned '1' after 0.59 seconds] DEBUG: Command: cat /etc/controllerimage Status: 1 Output: cat: /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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; which LSB_Test.sh DEBUG: Waiting for process output: time: 1680779980.0891826, endtime: 1680780280.0655391 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg > /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1680779980.5036378, endtime: 1680780280.4687989 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.44 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/ DEBUG: Waiting for process output: time: 1680779980.9428015, endtime: 1680780280.9076965 DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.42 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -d /var/log/ DEBUG: Waiting for process output: time: 1680779981.3563392, endtime: 1680780281.3325412 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.44 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; find /var/log//*.log -maxdepth 1 -type f DEBUG: Waiting for process output: time: 1680779981.791431, endtime: 1680780281.771774 DEBUG: Partial data from SSH call: /var/log//postinstall.log DEBUG: Waiting for process output: time: 1680779982.2011547, endtime: 1680780282.2011514 DEBUG: Data from SSH call: /var/log//postinstall.log DEBUG: [Command returned '0' after 0.63 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /var/log/dmesg DEBUG: Waiting for process output: time: 1680779982.4378138, endtime: 1680780282.4038477 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; test -f /tmp/dmesg_output.log DEBUG: Waiting for process output: time: 1680779982.878494, endtime: 1680780282.8316298 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.44 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.24:/var/log//postinstall.log /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-m4/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.25 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.24:/var/log/dmesg /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-m4/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.26 seconds] DEBUG: [Running]$ scp -o ServerAliveCountMax=2 -o ServerAliveInterval=30 -o UserKnownHostsFile=/dev/null -o StrictHostKeyChecking=no -o LogLevel=ERROR root@192.168.7.24:/tmp/dmesg_output.log /home/pokybuild/yocto-worker/qemuarm64-ptest/build/build/tmp/work/qemuarm64-poky-linux/core-image-ptest-m4/1.0-r0/target_logs DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.26 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.24 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: 1680779984.2300198, endtime: 1680780284.201616 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.43 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.24 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: 1680779984.6582518, endtime: 1680780284.631655 DEBUG: Data from SSH call: DEBUG: [Command returned '0' after 0.42 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; cat /proc/cpuinfo | grep "processor" | wc -l DEBUG: Waiting for process output: time: 1680779985.0928264, endtime: 1680780285.053166 DEBUG: Partial data from SSH call: 4 DEBUG: Waiting for process output: time: 1680779985.466488, endtime: 1680780285.466484 DEBUG: Data from SSH call: 4 DEBUG: [Command returned '0' after 0.62 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; uname -m DEBUG: Waiting for process output: time: 1680779985.6989806, endtime: 1680780285.669353 DEBUG: Partial data from SSH call: aarch64 DEBUG: Waiting for process output: time: 1680779986.1095188, endtime: 1680780286.1095147 DEBUG: Data from SSH call: aarch64 DEBUG: [Command returned '0' after 0.64 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.24 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.17 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; ptest-runner -t 450 -d "/usr/lib" DEBUG: Data from SSH call: START: ptest-runner 2023-04-06T11:19 BEGIN: /usr/lib/m4/ptest PASS: test-accept PASS: test-access PASS: test-alignof PASS: test-alloca-opt PASS: test-arpa_inet PASS: test-array_list PASS: test-array_oset PASS: test-asyncsafe-spin1 Skipping test: multithreading not enabled SKIP: test-asyncsafe-spin2 PASS: test-avltree_oset PASS: test-binary-io.sh PASS: test-bind PASS: test-bitrotate PASS: test-btowc1.sh PASS: test-btowc2.sh PASS: test-c-ctype PASS: test-c-stack.sh PASS: test-c-stack2.sh PASS: test-c-strcase.sh PASS: test-calloc-gnu PASS: test-canonicalize-lgpl PASS: test-canonicalize PASS: test-chdir PASS: test-cloexec PASS: test-close PASS: test-closein.sh PASS: test-connect PASS: test-creat PASS: test-ctype PASS: test-dirent PASS: test-dirname PASS: test-dup PASS: test-dup2 PASS: test-dynarray PASS: test-environ PASS: test-errno ./test-execute-main: test-execute-child subprocess failed: No such file or directory PASS: test-execute.sh ./test-execute-script: executable-script subprocess failed: Exec format error ./test-execute-script: executable-script.sh subprocess failed: Exec format error PASS: test-execute-script test_heap: address range is still mapped after free(). test_stack: count = 0 PASS: test-explicit_bzero PASS: test-fchdir PASS: test-fclose PASS: test-fcntl-h PASS: test-fcntl PASS: test-fdopen PASS: test-fdopendir PASS: test-fflush PASS: test-fflush2.sh PASS: test-fgetc PASS: test-filenamecat PASS: test-float PASS: test-fopen-gnu PASS: test-fopen-safer PASS: test-fopen PASS: test-fpending.sh PASS: test-fpurge PASS: test-fputc PASS: test-fread PASS: test-freadahead.sh PASS: test-freading PASS: test-free PASS: test-freopen PASS: test-frexp-nolibm PASS: test-frexpl-nolibm PASS: test-fseek.sh PASS: test-fseek2.sh PASS: test-fseeko.sh PASS: test-fseeko2.sh PASS: test-fseeko3.sh PASS: test-fseeko4.sh PASS: test-fstat PASS: test-fstatat PASS: test-ftell.sh PASS: test-ftell2.sh PASS: test-ftell3 PASS: test-ftello.sh PASS: test-ftello2.sh PASS: test-ftello3 PASS: test-ftello4.sh PASS: test-ftruncate.sh PASS: test-fwrite PASS: test-getcwd-lgpl PASS: test-getcwd.sh PASS: test-getdtablesize PASS: test-getopt-gnu PASS: test-getprogname PASS: test-getrandom PASS: test-gettimeofday PASS: test-hard-locale PASS: test-hash PASS: test-iconv-h PASS: test-iconv PASS: test-ignore-value PASS: test-inet_pton PASS: test-intprops PASS: test-inttostr PASS: test-inttypes PASS: test-ioctl PASS: test-isblank PASS: test-isnand-nolibm PASS: test-isnanf-nolibm PASS: test-isnanl-nolibm PASS: test-iswblank PASS: test-iswdigit.sh PASS: test-iswxdigit.sh PASS: test-langinfo PASS: test-limits-h PASS: test-link PASS: test-linked_list PASS: test-linkedhash_list PASS: test-listen PASS: test-locale PASS: test-localeconv PASS: test-localename PASS: test-lseek.sh PASS: test-lstat PASS: test-malloc-gnu PASS: test-malloca PASS: test-math PASS: test-mbrtowc1.sh PASS: test-mbrtowc2.sh Skipping test: no traditional japanese locale is supported SKIP: test-mbrtowc3.sh Skipping test: no transitional chinese locale is supported SKIP: test-mbrtowc4.sh PASS: test-mbrtowc5.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-1.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-2.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-3.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-4.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-5.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-6.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-7.sh PASS: test-mbsinit.sh PASS: test-mbsstr1 PASS: test-mbsstr2.sh Skipping test: no chinese GB18030 locale is supported SKIP: test-mbsstr3.sh PASS: test-memchr PASS: test-memchr2 PASS: test-memrchr PASS: test-mkdir PASS: test-nanosleep PASS: test-netinet_in PASS: test-nl_langinfo.sh Skipping test: multithreading not enabled SKIP: test-nl_langinfo-mt PASS: test-open PASS: test-openat PASS: test-pathmax PASS: test-perror.sh PASS: test-perror2 PASS: test-pipe PASS: test-pipe2 PASS: test-posix_spawn-open1 PASS: test-posix_spawn-open2 PASS: test-posix_spawn-inherit0 PASS: test-posix_spawn-inherit1 PASS: test-posix_spawn-script PASS: test-posix_spawn_file_actions_addchdir PASS: test-posix_spawn-chdir PASS: test-posix_spawn_file_actions_addclose PASS: test-posix_spawn_file_actions_adddup2 PASS: test-posix_spawn_file_actions_addopen PASS: test-posix_spawn-dup2-stdout PASS: test-posix_spawn-dup2-stdin PASS: test-posix_spawnp-script PASS: test-printf-frexp PASS: test-printf-frexpl PASS: test-pthread PASS: test-pthread-thread PASS: test-pthread_sigmask1 Skipping test: POSIX threads not enabled SKIP: test-pthread_sigmask2 PASS: test-quotearg-simple PASS: test-raise PASS: test-rawmemchr PASS: test-read-file PASS: test-readlink PASS: test-realloc-gnu PASS: test-reallocarray PASS: test-regex PASS: test-rename PASS: test-rmdir PASS: test-sched PASS: test-scratch-buffer Invalid nfd test... passed Invalid fd test... passed Unconnected socket test... passed Connected sockets test... passed General socket test with fork... passed Pipe test... passed PASS: test-select PASS: test-select-in.sh PASS: test-select-out.sh PASS: test-setenv PASS: test-setlocale_null Skipping test: multithreading not enabled SKIP: test-setlocale_null-mt-one Skipping test: multithreading not enabled SKIP: test-setlocale_null-mt-all PASS: test-setlocale1.sh PASS: test-setlocale2.sh PASS: test-setsockopt PASS: test-sigaction PASS: test-signal-h PASS: test-signbit PASS: test-sigpipe.sh PASS: test-sigprocmask Test passed. PASS: test-sigsegv-catch-segv1 Doing SIGSEGV pass 1. Fault 1 caught. Doing SIGSEGV pass 2. Fault 2 caught. Test passed. PASS: test-sigsegv-catch-segv2 Starting recursion pass 1. Stack overflow 1 caught. Starting recursion pass 2. Stack overflow 2 caught. Test passed. PASS: test-sigsegv-catch-stackoverflow1 Starting recursion pass 1. Stack overflow 1 caught. Starting recursion pass 2. Stack overflow 2 caught. Segmentation violation correctly detected. Segmentation violation correctly detected. Test passed. PASS: test-sigsegv-catch-stackoverflow2 PASS: test-sleep PASS: test-snprintf PASS: test-sockets PASS: test-spawn-pipe.sh ./test-spawn-pipe-script: executable-script subprocess failed: Exec format error ./test-spawn-pipe-script: executable-script.sh subprocess failed: Exec format error PASS: test-spawn-pipe-script PASS: test-spawn PASS: test-stat PASS: test-stat-time PASS: test-stdalign PASS: test-stdbool PASS: test-stddef PASS: test-stdint PASS: test-stdio PASS: test-stdlib PASS: test-strchrnul PASS: test-strerror PASS: test-strerror_r PASS: test-striconv PASS: test-string PASS: test-strnlen PASS: test-strsignal PASS: test-strstr PASS: test-strtod PASS: test-strtod1.sh PASS: test-symlink PASS: test-sys_ioctl PASS: test-sys_random PASS: test-sys_select PASS: test-sys_socket PASS: test-sys_stat PASS: test-sys_time PASS: test-sys_types PASS: test-sys_uio PASS: test-sys_wait PASS: test-init.sh PASS: test-thread_self Skipping test: multithreading not enabled SKIP: test-thread_create PASS: test-time PASS: test-dup-safer PASS: test-unistd PASS: test-u8-mbtoucr PASS: test-u8-uctomb PASS: test-uc_width PASS: uniwidth/test-uc_width2.sh PASS: test-unsetenv ./test-update-copyright.sh: skipping this test; your system has insufficient support for Perl SKIP: test-update-copyright.sh PASS: test-vasnprintf PASS: test-vasprintf-posix PASS: test-vasprintf test-vc-list-files-git.sh: skipped test: git not found in PATH SKIP: test-vc-list-files-git.sh test-vc-list-files-cvs.sh: skipped test: cvs not found in PATH SKIP: test-vc-list-files-cvs.sh PASS: test-verify test-verify.sh: skipped test: cannot compile error-free SKIP: test-verify.sh PASS: test-version-etc.sh PASS: test-wchar PASS: test-wcrtomb.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-1.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-2.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-3.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-4.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-5.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-6.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-7.sh PASS: test-wctype-h PASS: test-wcwidth PASS: test-write PASS: test-xalloc-die.sh PASS: test-xvasprintf ======================= All 240 tests passed (27 tests were not run) ======================= DURATION: 39 END: /usr/lib/m4/ptest 2023-04-06T11:20 STOP: ptest-runner TOTAL: 1 FAIL: 0 DEBUG: [Command returned '0' after 38.36 seconds] DEBUG: Command: ptest-runner -t 450 -d "/usr/lib" Status: 0 Output: START: ptest-runner 2023-04-06T11:19 BEGIN: /usr/lib/m4/ptest PASS: test-accept PASS: test-access PASS: test-alignof PASS: test-alloca-opt PASS: test-arpa_inet PASS: test-array_list PASS: test-array_oset PASS: test-asyncsafe-spin1 Skipping test: multithreading not enabled SKIP: test-asyncsafe-spin2 PASS: test-avltree_oset PASS: test-binary-io.sh PASS: test-bind PASS: test-bitrotate PASS: test-btowc1.sh PASS: test-btowc2.sh PASS: test-c-ctype PASS: test-c-stack.sh PASS: test-c-stack2.sh PASS: test-c-strcase.sh PASS: test-calloc-gnu PASS: test-canonicalize-lgpl PASS: test-canonicalize PASS: test-chdir PASS: test-cloexec PASS: test-close PASS: test-closein.sh PASS: test-connect PASS: test-creat PASS: test-ctype PASS: test-dirent PASS: test-dirname PASS: test-dup PASS: test-dup2 PASS: test-dynarray PASS: test-environ PASS: test-errno ./test-execute-main: test-execute-child subprocess failed: No such file or directory PASS: test-execute.sh ./test-execute-script: executable-script subprocess failed: Exec format error ./test-execute-script: executable-script.sh subprocess failed: Exec format error PASS: test-execute-script test_heap: address range is still mapped after free(). test_stack: count = 0 PASS: test-explicit_bzero PASS: test-fchdir PASS: test-fclose PASS: test-fcntl-h PASS: test-fcntl PASS: test-fdopen PASS: test-fdopendir PASS: test-fflush PASS: test-fflush2.sh PASS: test-fgetc PASS: test-filenamecat PASS: test-float PASS: test-fopen-gnu PASS: test-fopen-safer PASS: test-fopen PASS: test-fpending.sh PASS: test-fpurge PASS: test-fputc PASS: test-fread PASS: test-freadahead.sh PASS: test-freading PASS: test-free PASS: test-freopen PASS: test-frexp-nolibm PASS: test-frexpl-nolibm PASS: test-fseek.sh PASS: test-fseek2.sh PASS: test-fseeko.sh PASS: test-fseeko2.sh PASS: test-fseeko3.sh PASS: test-fseeko4.sh PASS: test-fstat PASS: test-fstatat PASS: test-ftell.sh PASS: test-ftell2.sh PASS: test-ftell3 PASS: test-ftello.sh PASS: test-ftello2.sh PASS: test-ftello3 PASS: test-ftello4.sh PASS: test-ftruncate.sh PASS: test-fwrite PASS: test-getcwd-lgpl PASS: test-getcwd.sh PASS: test-getdtablesize PASS: test-getopt-gnu PASS: test-getprogname PASS: test-getrandom PASS: test-gettimeofday PASS: test-hard-locale PASS: test-hash PASS: test-iconv-h PASS: test-iconv PASS: test-ignore-value PASS: test-inet_pton PASS: test-intprops PASS: test-inttostr PASS: test-inttypes PASS: test-ioctl PASS: test-isblank PASS: test-isnand-nolibm PASS: test-isnanf-nolibm PASS: test-isnanl-nolibm PASS: test-iswblank PASS: test-iswdigit.sh PASS: test-iswxdigit.sh PASS: test-langinfo PASS: test-limits-h PASS: test-link PASS: test-linked_list PASS: test-linkedhash_list PASS: test-listen PASS: test-locale PASS: test-localeconv PASS: test-localename PASS: test-lseek.sh PASS: test-lstat PASS: test-malloc-gnu PASS: test-malloca PASS: test-math PASS: test-mbrtowc1.sh PASS: test-mbrtowc2.sh Skipping test: no traditional japanese locale is supported SKIP: test-mbrtowc3.sh Skipping test: no transitional chinese locale is supported SKIP: test-mbrtowc4.sh PASS: test-mbrtowc5.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-1.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-2.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-3.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-4.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-5.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-6.sh Skipping test: not a native Windows system SKIP: test-mbrtowc-w32-7.sh PASS: test-mbsinit.sh PASS: test-mbsstr1 PASS: test-mbsstr2.sh Skipping test: no chinese GB18030 locale is supported SKIP: test-mbsstr3.sh PASS: test-memchr PASS: test-memchr2 PASS: test-memrchr PASS: test-mkdir PASS: test-nanosleep PASS: test-netinet_in PASS: test-nl_langinfo.sh Skipping test: multithreading not enabled SKIP: test-nl_langinfo-mt PASS: test-open PASS: test-openat PASS: test-pathmax PASS: test-perror.sh PASS: test-perror2 PASS: test-pipe PASS: test-pipe2 PASS: test-posix_spawn-open1 PASS: test-posix_spawn-open2 PASS: test-posix_spawn-inherit0 PASS: test-posix_spawn-inherit1 PASS: test-posix_spawn-script PASS: test-posix_spawn_file_actions_addchdir PASS: test-posix_spawn-chdir PASS: test-posix_spawn_file_actions_addclose PASS: test-posix_spawn_file_actions_adddup2 PASS: test-posix_spawn_file_actions_addopen PASS: test-posix_spawn-dup2-stdout PASS: test-posix_spawn-dup2-stdin PASS: test-posix_spawnp-script PASS: test-printf-frexp PASS: test-printf-frexpl PASS: test-pthread PASS: test-pthread-thread PASS: test-pthread_sigmask1 Skipping test: POSIX threads not enabled SKIP: test-pthread_sigmask2 PASS: test-quotearg-simple PASS: test-raise PASS: test-rawmemchr PASS: test-read-file PASS: test-readlink PASS: test-realloc-gnu PASS: test-reallocarray PASS: test-regex PASS: test-rename PASS: test-rmdir PASS: test-sched PASS: test-scratch-buffer Invalid nfd test... passed Invalid fd test... passed Unconnected socket test... passed Connected sockets test... passed General socket test with fork... passed Pipe test... passed PASS: test-select PASS: test-select-in.sh PASS: test-select-out.sh PASS: test-setenv PASS: test-setlocale_null Skipping test: multithreading not enabled SKIP: test-setlocale_null-mt-one Skipping test: multithreading not enabled SKIP: test-setlocale_null-mt-all PASS: test-setlocale1.sh PASS: test-setlocale2.sh PASS: test-setsockopt PASS: test-sigaction PASS: test-signal-h PASS: test-signbit PASS: test-sigpipe.sh PASS: test-sigprocmask Test passed. PASS: test-sigsegv-catch-segv1 Doing SIGSEGV pass 1. Fault 1 caught. Doing SIGSEGV pass 2. Fault 2 caught. Test passed. PASS: test-sigsegv-catch-segv2 Starting recursion pass 1. Stack overflow 1 caught. Starting recursion pass 2. Stack overflow 2 caught. Test passed. PASS: test-sigsegv-catch-stackoverflow1 Starting recursion pass 1. Stack overflow 1 caught. Starting recursion pass 2. Stack overflow 2 caught. Segmentation violation correctly detected. Segmentation violation correctly detected. Test passed. PASS: test-sigsegv-catch-stackoverflow2 PASS: test-sleep PASS: test-snprintf PASS: test-sockets PASS: test-spawn-pipe.sh ./test-spawn-pipe-script: executable-script subprocess failed: Exec format error ./test-spawn-pipe-script: executable-script.sh subprocess failed: Exec format error PASS: test-spawn-pipe-script PASS: test-spawn PASS: test-stat PASS: test-stat-time PASS: test-stdalign PASS: test-stdbool PASS: test-stddef PASS: test-stdint PASS: test-stdio PASS: test-stdlib PASS: test-strchrnul PASS: test-strerror PASS: test-strerror_r PASS: test-striconv PASS: test-string PASS: test-strnlen PASS: test-strsignal PASS: test-strstr PASS: test-strtod PASS: test-strtod1.sh PASS: test-symlink PASS: test-sys_ioctl PASS: test-sys_random PASS: test-sys_select PASS: test-sys_socket PASS: test-sys_stat PASS: test-sys_time PASS: test-sys_types PASS: test-sys_uio PASS: test-sys_wait PASS: test-init.sh PASS: test-thread_self Skipping test: multithreading not enabled SKIP: test-thread_create PASS: test-time PASS: test-dup-safer PASS: test-unistd PASS: test-u8-mbtoucr PASS: test-u8-uctomb PASS: test-uc_width PASS: uniwidth/test-uc_width2.sh PASS: test-unsetenv ./test-update-copyright.sh: skipping this test; your system has insufficient support for Perl SKIP: test-update-copyright.sh PASS: test-vasnprintf PASS: test-vasprintf-posix PASS: test-vasprintf test-vc-list-files-git.sh: skipped test: git not found in PATH SKIP: test-vc-list-files-git.sh test-vc-list-files-cvs.sh: skipped test: cvs not found in PATH SKIP: test-vc-list-files-cvs.sh PASS: test-verify test-verify.sh: skipped test: cannot compile error-free SKIP: test-verify.sh PASS: test-version-etc.sh PASS: test-wchar PASS: test-wcrtomb.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-1.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-2.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-3.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-4.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-5.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-6.sh Skipping test: not a native Windows system SKIP: test-wcrtomb-w32-7.sh PASS: test-wctype-h PASS: test-wcwidth PASS: test-write PASS: test-xalloc-die.sh PASS: test-xvasprintf ======================= All 240 tests passed (27 tests were not run) ======================= DURATION: 39 END: /usr/lib/m4/ptest 2023-04-06T11:20 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.24 export PATH=/usr/sbin:/sbin:/usr/bin:/bin; dmesg | grep "Killed process" DEBUG: Data from SSH call: DEBUG: [Command returned '1' after 0.27 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 46.367s 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: 239667.73 runqemu - INFO - Removing /home/pokybuild/tmp/core-image-ptest-m4-qemuarm64.ext4.670670 tput: No value for $TERM and no -T specified RESULTS: RESULTS - parselogs.ParseLogsTest.test_parselogs: PASSED (5.85s) RESULTS - ping.PingTest.test_ping: PASSED (0.11s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectfail: PASSED (38.81s) RESULTS - ssh.SSHTest.test_ssh: PASSED (1.20s) RESULTS - ptest.PtestRunnerTest.test_ptestrunner_expectsuccess: SKIPPED (0.00s) SUMMARY: core-image-ptest-m4 () - Ran 5 tests in 46.370s core-image-ptest-m4 - 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