DEBUG: Executing python function extend_recipe_sysroot
NOTE: Direct dependencies are ['/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/qemu/qemu-helper-native_1.0.bb:do_populate_sysroot', '/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/qemu/qemu-native_10.2.0.bb:do_populate_sysroot', '/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/qemu/qemu-system-native_10.2.0.bb:do_populate_sysroot', 'virtual:native:/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/apt/apt_3.0.3.bb:do_populate_sysroot', 'virtual:native:/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/dpkg/dpkg_1.23.7.bb:do_populate_sysroot', 'virtual:native:/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/pseudo/pseudo_git.bb:do_populate_sysroot', 'virtual:native:/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/recipes-devtools/unfs3/unfs3_0.11.0.bb:do_populate_sysroot']
NOTE: Task do_testimage no longer depends on libsolv-native, removing from sysroot
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/cmake/Modules/FindLibSolv.cmake
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/bitmap.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/chksum.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/pooltypes.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/poolarch.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/solvversion.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/poolvendor.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/repo_solv.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/knownid.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/strpool.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/testcase.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/dataiterator.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/solverdebug.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/repo_write.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/util.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/hash.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/policy.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/poolid.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/transaction.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/dirpool.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/repo.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/tools_util.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/solv_xfopen.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/evr.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/problems.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/solvable.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/pool.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/solver.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/queue.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/repodata.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/selection.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/rules.h
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/mergesolv
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/testsolv
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/installcheck
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/dumpsolv
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/repo2solv
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolvext.so
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolv.a
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolvext.so.1
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolv.so
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolvext.a
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libsolv.so.1
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/pkgconfig/libsolvext.pc
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/pkgconfig/libsolv.pc
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/sysroot-providers/libsolv-native
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/cmake/Modules/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/pkgconfig/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/sysroot-providers/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/solv/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/cmake/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/include/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/
NOTE: Task do_testimage no longer depends on opkg-native, removing from sysroot
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/opkg/intercept/depmod
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/opkg/intercept/update-modules
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/opkg/intercept/ldconfig
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/opkg-check-config
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/opkg
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libopkg.so.1.0.0
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libopkg.so
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/libopkg.so.1
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/pkgconfig/libopkg.pc
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/sysroot-providers/opkg-native
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/etc/opkg/opkg.conf
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/opkg/intercept/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/pkgconfig/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/sysroot-providers/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/opkg/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/share/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/etc/opkg/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/lib/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/bin/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/etc/
DEBUG: Removing manifest: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/recipe-sysroot-native/usr/
NOTE: Installed into sysroot: []
NOTE: Skipping as already exists in sysroot: ['gettext-minimal-native', 'llvm-tblgen-native', 'cmake-native', 'libtool-native', 'm4-native', 'qemu-helper-native', 'qemu-native', 'qemu-system-native', 'texinfo-dummy-native', 'mesa-tools-native', 'openssl-native', 'libslirp-native', 'expat-native', 'gettext-native', 'glib-2.0-native', 'libxml2-native', 'ncurses-native', 'util-linux-libuuid-native', 'zlib-native', 'apt-native', 'binutils-native', 'chrpath-native', 'clang-native', 'libclc-native', 'llvm-native', 'dpkg-native', 'elfutils-native', 'flex-native', 'gnu-config-native', 'json-c-native', 'libedit-native', 'make-native', 'opkg-utils-native', 'perl-native', 'pseudo-native', 'python3-build-native', 'python3-calver-native', 'python3-cython-native', 'python3-editables-native', 'python3-flit-core-native', 'python3-hatchling-native', 'python3-installer-native', 'python3-mako-native', 'python3-markupsafe-native', 'python3-packaging-native', 'python3-pathspec-native', 'python3-pluggy-native', 'python3-pygments-native', 'python3-pyproject-hooks-native', 'python3-pyyaml-native', 'python3-setuptools-scm-native', 'python3-setuptools-native', 'python3-trove-classifiers-native', 'python3-typing-extensions-native', 'python3-vcs-versioning-native', 'python3-wheel-native', 'python3-native', 'unfs3-native', 'bzip2-native', 'diffutils-native', 'libarchive-native', 'libidn2-native', 'libtirpc-native', 'unzip-native', 'xz-native', 'zstd-native', 'libdrm-native', 'libepoxy-native', 'libsdl2-native', 'mesa-native', 'spirv-headers-native', 'spirv-llvm-translator-native', 'spirv-tools-native', 'virglrenderer-native', 'wayland-protocols-native', 'wayland-native', 'xrandr-native', 'libpciaccess-native', 'libpthread-stubs-native', 'libx11-native', 'libxau-native', 'libxcb-native', 'libxdamage-native', 'libxdmcp-native', 'libxext-native', 'libxfixes-native', 'libxrandr-native', 'libxrender-native', 'libxshmfence-native', 'libxxf86vm-native', 'pixman-native', 'xtrans-native', 'xcb-proto-native', 'xorgproto-native', 'makedepend-native', 'util-macros-native', 'dtc-native', 'alsa-lib-native', 'libpng-native', 'acl-native', 'attr-native', 'curl-native', 'db-native', 'gdbm-native', 'gmp-native', 'gnutls-native', 'libtasn1-native', 'libcap-native', 'libffi-native', 'libgcrypt-native', 'libgpg-error-native', 'libmd-native', 'libmicrohttpd-native', 'libpcre2-native', 'libunistring-native', 'libyaml-native', 'lz4-native', 'nettle-native', 'p11-kit-native', 'sqlite3-native', 'xxhash-native']
DEBUG: Python function extend_recipe_sysroot finished
DEBUG: Executing python function do_testimage
DEBUG: test suites:
	test_apt_install_from_repo (apt.AptRepoTest)
	test_ping (ping.PingTest)
	test_ssh (ssh.SSHTest)
	test_cpio (buildcpio.BuildCpioTest)
	test_galculator (buildgalculator.GalculatorTest)
	test_lzip (buildlzip.BuildLzipTest)
	test_connmand_help (connman.ConnmanTest)
	test_connmand_running (connman.ConnmanTest)
	test_date (date.DateTest)
	test_df (df.DfTest)
	test_dnf_help (dnf.DnfBasicTest)
	test_dnf_history (dnf.DnfBasicTest)
	test_dnf_info (dnf.DnfBasicTest)
	test_dnf_search (dnf.DnfBasicTest)
	test_dnf_version (dnf.DnfBasicTest)
	test_dnf_makecache (dnf.DnfRepoTest)
	test_dnf_exclude (dnf.DnfRepoTest)
	test_dnf_install (dnf.DnfRepoTest)
	test_dnf_install_dependency (dnf.DnfRepoTest)
	test_dnf_install_from_disk (dnf.DnfRepoTest)
	test_dnf_install_from_http (dnf.DnfRepoTest)
	test_dnf_installroot (dnf.DnfRepoTest)
	test_dnf_installroot_usrmerge (dnf.DnfRepoTest)
	test_dnf_reinstall (dnf.DnfRepoTest)
	test_dnf_repoinfo (dnf.DnfRepoTest)
	test_gcc_compile (gcc.GccCompileTest)
	test_gpp2_compile (gcc.GccCompileTest)
	test_gpp_compile (gcc.GccCompileTest)
	test_make (gcc.GccCompileTest)
	test_python (gi.GObjectIntrospectionTest)
	test_go_compile (go.GoCompileTest)
	test_go_module (go.GoCompileTest)
	test_gohelloworld (go.GoHelloworldTest)
	test_kernel_module (kernelmodule.KernelModuleTest)
	test_ldd (ldd.LddTest)
	test_logrotate_wtmp (logrotate.LogrotateTest)
	test_logrotate_newlog (logrotate.LogrotateTest)
	test_syslog_running (oe_syslog.SyslogTest)
	test_syslog_logger (oe_syslog.SyslogTestConfig)
	test_syslog_restart (oe_syslog.SyslogTestConfig)
	test_syslog_startup_config (oe_syslog.SyslogTestConfig)
	test_opkg_install_from_repo (opkg.OpkgRepoTest)
	test_pam (pam.PamBasicTest)
	test_get_context (parselogs.ParseLogsTest)
	test_parselogs (parselogs.ParseLogsTest)
	test_perl_works (perl.PerlTest)
	test_ptestrunner_expectfail (ptest.PtestRunnerTest)
	test_ptestrunner_expectsuccess (ptest.PtestRunnerTest)
	test_python3 (python.PythonTest)
	test_rpm_help (rpm.RpmBasicTest)
	test_rpm_query (rpm.RpmBasicTest)
	test_rpm_query_nonroot (rpm.RpmBasicTest)
	test_rpm_install (rpm.RpmInstallRemoveTest)
	test_rpm_remove (rpm.RpmInstallRemoveTest)
	test_check_rpm_install_removal_log_file_size (rpm.RpmInstallRemoveTest)
	test_rust_c_lib_example (rust.RustCLibExampleTest)
	test_cargo_compile (rust.RustCompileTest)
	test_rust_compile (rust.RustCompileTest)
	test_scp_file (scp.ScpTest)
	test_stap (stap.StapTest)
	test_systemd_basic (systemd.SystemdBasicTests)
	test_systemd_failed (systemd.SystemdBasicTests)
	test_systemd_list (systemd.SystemdBasicTests)
	test_systemd_boot_time (systemd.SystemdJournalTests)
	test_systemd_journal (systemd.SystemdJournalTests)
	test_systemd_coredump_minidebuginfo (systemd.SystemdServiceTests)
	test_systemd_status (systemd.SystemdServiceTests)
	test_systemd_disable_enable (systemd.SystemdServiceTests)
	test_systemd_disable_enable_ro (systemd.SystemdServiceTests)
	test_systemd_stop_start (systemd.SystemdServiceTests)
	test_wayland_info (weston.WestonTest)
	test_weston_can_initialize_new_wayland_compositor (weston.WestonTest)
	test_weston_running (weston.WestonTest)
	test_weston_supports_xwayland (weston.WestonTest)
	test_xorg_running (xorg.XorgTest)
DEBUG: Not using kvm for runqemu
QMP Available for connection at TOPDIR/tmp/.hc1xyq_p
DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:47971
DEBUG: Created listening socket for qemu serial console on: 127.0.0.1:49123
DEBUG: launchcmd=runqemu snapshot  qemuarm64 TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs.ext4.zst tcpserial=47971:49123 bootparams=" printk.time=1" qemuparams="-pidfile TOPDIR/pidfile_2556571  -S -qmp unix:./.rtr4v03b,server,wait -qmp unix:./.hc1xyq_p,server,nowait"
DEBUG: runqemu started, pid is 2556575
DEBUG: waiting at most 300 seconds for qemu pid (05/09/26 01:57:20)
DEBUG: QMP Initializing to TOPDIR/tmp/.rtr4v03b
DEBUG: QMP Connecting to TOPDIR/tmp/.rtr4v03b
QMP connected to QEMU at 05/09/26 01:57:25 and took 5.05 seconds
QMP released QEMU at 05/09/26 01:57:26 and took 0.12 seconds from connect
DEBUG: qemu started in 5.16 seconds - qemu procces pid is 2556625 (05/09/26 01:57:26)
DEBUG: qemu cmdline used:
TOPDIR/tmp/work/x86_64-linux/qemu-helper-native/1.0/recipe-sysroot-native/usr/bin/qemu-system-aarch64 -device virtio-net-pci,netdev=net0,mac=52:54:00:12:34:06 -netdev tap,id=net0,ifname=tap2,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-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576,if=none,format=raw -device virtio-blk-pci,drive=disk0 -device qemu-xhci -device usb-tablet -device usb-kbd -machine virt -cpu cortex-a57 -smp 4 -m 1024 -device virtio-serial-pci -chardev socket,id=virtcon,port=47971,host=127.0.0.1,nodelay=on -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:49123,nodelay=on -pidfile TOPDIR/pidfile_2556571 -S -qmp unix:./.rtr4v03b,server,wait -qmp unix:./.hc1xyq_p,server,nowait -serial null -serial mon:vc -vnc unix:/tmp/qemu-tap-locks/tap2.vnc-socket -device virtio-gpu-pci -kernel TOPDIR/tmp/deploy/images/qemuarm64/Image -append root=/dev/vda rw  mem=1024M ip=192.168.7.6::192.168.7.5:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0 console=ttyAMA0 console=hvc0 swiotlb=0  printk.time=1 
DEBUG: Target IP: 192.168.7.6
DEBUG: Server IP: 192.168.7.5
DEBUG: Starting logging thread
DEBUG: Starting thread event loop
DEBUG: Connection request received
DEBUG: Setting connection established event
DEBUG: Output from runqemu:
runqemu - INFO - Decompressing TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs.ext4.zst to TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4
TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.zst: 3482419200 bytes 
runqemu - INFO - Continuing with the following parameters:
KERNEL: [TOPDIR/tmp/deploy/images/qemuarm64/Image]
MACHINE: [qemuarm64]
FSTYPE: [ext4]
ROOTFS: [TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4]
SNAPSHOT: [Enabled. Changes on rootfs won't be kept after QEMU shutdown.]
CONFFILE: [TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs.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 - Using preconfigured tap device tap2
runqemu - INFO - If this is not intended, touch /tmp/qemu-tap-locks/tap2.skip to make runqemu skip tap2.
runqemu - INFO - Network configuration: ip=192.168.7.6::192.168.7.5:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0
runqemu - INFO - Copying rootfs to /home/pokybuild/tmp/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576
runqemu - INFO - Copy done in 1.1993677616119385 seconds
runqemu - INFO - Using VNC server at unix:/tmp/qemu-tap-locks/tap2.vnc-socket for graphical output
runqemu - INFO - Running TOPDIR/tmp/work/x86_64-linux/qemu-helper-native/1.0/recipe-sysroot-native/usr/bin/qemu-system-aarch64 -device virtio-net-pci,netdev=net0,mac=52:54:00:12:34:06 -netdev tap,id=net0,ifname=tap2,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-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576,if=none,format=raw -device virtio-blk-pci,drive=disk0 -device qemu-xhci -device usb-tablet -device usb-kbd  -machine virt -cpu cortex-a57 -smp 4 -m 1024 -device virtio-serial-pci -chardev socket,id=virtcon,port=47971,host=127.0.0.1,nodelay=on -device virtconsole,chardev=virtcon -serial tcp:127.0.0.1:49123,nodelay=on  -pidfile TOPDIR/pidfile_2556571  -S -qmp unix:./.rtr4v03b,server,wait -qmp unix:./.hc1xyq_p,server,nowait -serial null -serial mon:vc -vnc unix:/tmp/qemu-tap-locks/tap2.vnc-socket -device virtio-gpu-pci -kernel TOPDIR/tmp/deploy/images/qemuarm64/Image -append 'root=/dev/vda rw  mem=1024M ip=192.168.7.6::192.168.7.5:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0 console=ttyAMA0 console=hvc0 swiotlb=0  printk.time=1'

runqemu - INFO - Host uptime: 356546.56


DEBUG: Waiting at most 1500 seconds for login banner (05/09/26 01:57:26)
DEBUG: Connection from 127.0.0.1:38086
DEBUG: Partial boot log:
[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd070]
[    0.000000] Linux version 6.18.24-yocto-standard (oe-user@oe-host) (aarch64-poky-linux-gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1 SMP PREEMPT Thu Apr 23 15:17:42 UTC 2026
[    0.000000] random: crng init done
[    0.000000] Machine model: linux,dummy-virt
[    0.000000] Memory limited to 1024MB
[    0.000000] efi: UEFI not found.
[    0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000040000000-0x000000007fffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000040000000-0x000000007fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[
DEBUG: Partial boot log:
    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: Trusted OS migration not required
[    0.000000] psci: SMC Calling Convention v1.0
[    0.000000] percpu: Embedded 28 pages/cpu s75992 r8192 d30504 u114688
[    0.000000] Detected PIPT I-cache on CPU0
[    0.000000] CPU features: detected: Spectre-v2
[    0.000000] CPU features: detected: Spectre-v4
[    0.000000] CPU features: detected: Spectre-BHB
[    0.000000] CPU features: detected: ARM erratum 1742098
[    0.000000] CPU features: detected: ARM erratum 832075
[    0.000000] CPU features: detected: ARM errata 1165522, 1319367, or 1530923
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Kernel command line: root=/dev/vda rw  mem=1024M ip=192.168.7.6::192.168.7.5:255.255.255.0::eth0:off:8.8.8.8 net.ifnames=0 console=ttyAMA0 console=hvc0 swiotlb=0  printk.time=1
[    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
[    0.000000] Dentry cache hash table entries: 1310
DEBUG: Partial boot log:
72 (order: 8, 1048576 bytes, linear)
[    0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.000000] software IO TLB: area num 4.
[    0.000000] software IO TLB: SWIOTLB bounce buffer size roundup to 1MB
[    0.000000] software IO TLB: mapped [mem 0x000000007e880000-0x000000007e980000] (1MB)
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 262144
[    0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] ftrace: allocating 44608 entries in 176 pages
[    0.000000] ftrace: allocated 176 pages with 3 groups
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
[    0.000000] 	Trampoline variant of Tasks RCU enabled.
[    0.000000] 	Rude variant of Tasks RCU enabled.
[    0.000000] 	Tracing variant o
DEBUG: Partial boot log:
f Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[    0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[    0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143]
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] arch_timer: cp15 timer running at 62.50MHz (virt).
[    0.000000] clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns
[    0.000053] sched_clock: 57 bits at 63MHz, resolution 16ns, wraps ever
DEBUG: Partial boot log:
y 4398046511096ns
[    0.007886] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
[    0.013754] Console: colour dummy device 80x25
[    0.015017] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000)
[    0.015167] pid_max: default: 32768 minimum: 301
[    0.017537] LSM: initializing lsm=capability,landlock
[    0.018807] landlock: Up and running.
[    0.021180] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[    0.021214] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[    0.043576] cacheinfo: Unable to detect cache hierarchy for CPU 0
[    0.055548] rcu: Hierarchical SRCU implementation.
[    0.055580] rcu: 	Max phase no-delay instances is 1000.
[    0.058273] EFI services will not be available.
[    0.059044] smp: Bringing up secondary CPUs ...
[    0.063809] Detected PIPT I-cache on CPU1
[    0.066133] CPU1: Booted secondary processor 0x000000
DEBUG: Partial boot log:
0001 [0x411fd070]
[    0.074305] Detected PIPT I-cache on CPU2
[    0.074914] CPU2: Booted secondary processor 0x0000000002 [0x411fd070]
[    0.077193] Detected PIPT I-cache on CPU3
[    0.077791] CPU3: Booted secondary processor 0x0000000003 [0x411fd070]
[    0.078567] smp: Brought up 1 node, 4 CPUs
[    0.078595] SMP: Total of 4 processors activated.
[    0.078619] CPU: All CPU(s) started at EL1
[    0.078686] CPU features: detected: 32-bit EL0 Support
[    0.078752] CPU features: detected: CRC32 instructions
[    0.078890] CPU features: detected: PMUv3
[    0.092047] alternatives: applying system-wide alternatives
[    0.114448] Memory: 994284K/1048576K available (14848K kernel code, 2134K rwdata, 3736K rodata, 1856K init, 642K bss, 48344K reserved, 0K cma-reserved)
[    0.159757] devtmpfs: initialized
[    0.180430] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.181863] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linea
DEBUG: Partial boot log:
r)
[    0.182798] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).
[    0.185609] 26912 pages in range for non-PLT usage
[    0.185718] 518432 pages in range for PLT usage
[    0.195513] DMI not present or invalid.
[    0.237253] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.245132] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
[    0.245769] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.246049] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
[    0.251420] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.252705] ASID allocator initialised with 65536 entries
[    0.253118] Serial: AMBA PL011 UART driver
[    0.281400] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1
[    0.286361] printk: console [ttyAMA0] enabled
[    0.297228] 9040000.pl011: ttyAMA1 at MMIO 0x9040000 (irq = 14, base_baud = 0) is a PL011 rev1
[    
DEBUG: Partial boot log:
0.394622] raid6: neonx8   gen()  2953 MB/s
[    0.463241] raid6: neonx4   gen()  3476 MB/s
[    0.531964] raid6: neonx2   gen()  2302 MB/s
[    0.600665] raid6: neonx1   gen()  1314 MB/s
[    0.669336] raid6: int64x8  gen()  1786 MB/s
[    0.738037] raid6: int64x4  gen()  2328 MB/s
[    0.806685] raid6: int64x2  gen()  2041 MB/s
[    0.876674] raid6: int64x1  gen()   405 MB/s
[    0.876773] raid6: using algorithm neonx4 gen() 3476 MB/s
[    0.944091] raid6: .... xor() 1478 MB/s, rmw enabled
[    0.944227] raid6: using neon recovery algorithm
[    0.946859] iommu: Default domain type: Translated
[    0.946919] iommu: DMA domain TLB invalidation policy: strict mode
[    0.954924] SCSI subsystem initialized
[    0.955627] usbcore: registered new interface driver usbfs
[    0.955935] usbcore: registered new interface driver hub
[    0.956067] usbcore: registered new device driver usb
[    0.956973] pps_core: LinuxPPS API ver. 1 registered
[    0.957019] pps_core: Software ver. 5.3.6 - Copyright 
DEBUG: Partial boot log:
2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.957089] PTP clock support registered
[    0.972806] vgaarb: loaded
[    0.974257] clocksource: Switched to clocksource arch_sys_counter
[    1.011934] NET: Registered PF_INET protocol family
[    1.012984] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    1.021866] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
[    1.022092] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    1.023221] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    1.024167] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
[    1.025089] TCP: Hash tables configured (established 8192 bind 8192)
[    1.026714] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
[    1.027159] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
[    1.028506] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    1.032297] RPC: Registered named 
DEBUG: Partial boot log:
UNIX socket transport module.
[    1.032374] RPC: Registered udp transport module.
[    1.032384] RPC: Registered tcp transport module.
[    1.032400] RPC: Registered tcp-with-tls transport module.
[    1.032407] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.032539] PCI: CLS 0 bytes, default 64

DEBUG: Partial boot log:
[    1.346683] workingset: timestamp_bits=46 max_order=18 bucket_order=0
[    1.351737] NFS: Registering the id_resolver key type
[    1.352070] Key type id_resolver registered
[    1.352317] Key type id_legacy registered
[    1.357504] Key type cifs.idmap registered
[    1.409617] xor: measuring software checksum speed
[    1.411572]    8regs           :  1786 MB/sec
[    1.412467]    32regs          :  3903 MB/sec
[    1.413580]    arm64_neon      :  3031 MB/sec
[    1.413637] xor: using function: 32regs (3903 MB/sec)
[    1.415586] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[    1.416093] io scheduler mq-deadline registered
[    1.416267] io scheduler kyber registered
[    1.421261] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
[    1.422495] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
[    1.424669] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
[    1.424928] p
DEBUG: Partial boot log:
ci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
[    1.425381] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
[    1.425878] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
[    1.428061] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
[    1.428275] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.428602] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    1.428644] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
[    1.428653] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
[    1.430338] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
[    1.435132] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
[    1.435418] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
[    1.435875] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
[    1.435986] pci 0000:00:01.0: BAR 4 [me
DEBUG: Partial boot log:
m 0x00000000-0x00003fff 64bit pref]
[    1.436092] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]
[    1.438509] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
[    1.438614] pci 0000:00:02.0: BAR 0 [io  0x0000-0x001f]
[    1.438629] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]
[    1.439140] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
[    1.440861] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
[    1.440990] pci 0000:00:03.0: BAR 0 [io  0x0000-0x007f]
[    1.441489] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]
[    1.441683] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
[    1.443508] pci 0000:00:04.0: [1b36:000d] type 00 class 0x0c0330 PCIe Root Complex Integrated Endpoint
[    1.443614] pci 0000:00:04.0: BAR 0 [mem 0x00000000-0x00003fff 64bit]
[    1.444726] pci 0000:00:04.0: enabling Extended Tags
[    1.445687] pci 0000:00:05.0: [1af4:1003] type 00 class 0x078000 conven
DEBUG: Partial boot log:
tional PCI endpoint
[    1.445855] pci 0000:00:05.0: BAR 0 [io  0x0000-0x003f]
[    1.446150] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]
[    1.446178] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
[    1.447291] pci 0000:00:06.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint
[    1.447383] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]
[    1.447396] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
[    1.450131] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned
[    1.450455] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
[    1.450765] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned
[    1.451067] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned
[    1.451278] pci 0000:00:04.0: BAR 0 [mem 0x800000c000-0x800000ffff 64bit]: assigned
[    1.451495] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned
[    1.451556
DEBUG: Partial boot log:
] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned
[    1.452089] pci 0000:00:01.0: BAR 1 [mem 0x10040000-0x10040fff]: assigned
[    1.452178] pci 0000:00:02.0: BAR 1 [mem 0x10041000-0x10041fff]: assigned
[    1.452260] pci 0000:00:03.0: BAR 1 [mem 0x10042000-0x10042fff]: assigned
[    1.452273] pci 0000:00:05.0: BAR 1 [mem 0x10043000-0x10043fff]: assigned
[    1.452284] pci 0000:00:06.0: BAR 1 [mem 0x10044000-0x10044fff]: assigned
[    1.452912] pci 0000:00:03.0: BAR 0 [io  0x1000-0x107f]: assigned
[    1.452981] pci 0000:00:05.0: BAR 0 [io  0x1080-0x10bf]: assigned
[    1.452995] pci 0000:00:01.0: BAR 0 [io  0x10c0-0x10df]: assigned
[    1.453211] pci 0000:00:02.0: BAR 0 [io  0x10e0-0x10ff]: assigned
[    1.453480] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
[    1.453505] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]
[    1.453515] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]
[    1.459565] pci 0000:00:04.0: enabling device (0000 -> 0002
DEBUG: Partial boot log:
)
[    1.476927] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
[    1.481278] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
[    1.484276] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
[    1.487218] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
[    1.491521] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)
[    1.536154] [drm] pci: virtio-gpu-pci detected at 0000:00:06.0
[    1.537523] [drm] features: -virgl +edid -resource_blob -host_visible
[    1.537576] [drm] features: -context_init
[    1.540399] [drm] number of scanouts: 1
[    1.540467] [drm] number of cap sets: 0
[    1.552803] printk: legacy console [hvc0] enabled
[    1.555662] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:06.0 on minor 0
[    1.615305] Console: switching to colour frame buffer device 160x50
[    1.630916] virtio-pci 0000:00:06.0: [drm] fb0: virtio_gpudrmfb frame buffer device
[    1.666743] brd: module loaded
[    1.668166] virtio_blk virtio2: 4/0/0 default/read/poll
DEBUG: Partial boot log:
 queues
[    1.675664] virtio_blk virtio2: [vda] 6801600 512-byte logical blocks (3.48 GB/3.24 GiB)
[    1.691261] xhci_hcd 0000:00:04.0: xHCI Host Controller
[    1.692043] xhci_hcd 0000:00:04.0: new USB bus registered, assigned bus number 1
[    1.697660] xhci_hcd 0000:00:04.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010
[    1.702937] xhci_hcd 0000:00:04.0: xHCI Host Controller
[    1.704253] xhci_hcd 0000:00:04.0: new USB bus registered, assigned bus number 2
[    1.706417] xhci_hcd 0000:00:04.0: Host supports USB 3.0 SuperSpeed
[    1.714993] hub 1-0:1.0: USB hub found
[    1.716575] hub 1-0:1.0: 4 ports detected
[    1.720911] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    1.724768] hub 2-0:1.0: USB hub found
[    1.725889] hub 2-0:1.0: 4 ports detected
[    1.732602] rtc-pl031 9010000.pl031: registered as rtc0
[    1.734835] rtc-pl031 9010000.pl031: setting system clock to 2026-05-09T01:57:29 UTC (1778291849)
[    1.739781] device-
DEBUG: Partial boot log:
mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
[    1.749152] usbcore: registered new interface driver usbhid
[    1.751057] usbhid: USB HID core driver
[    1.760063] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available
[    1.764626] u32 classifier
[    1.765470]     input device check on
[    1.766733]     Actions configured
[    1.773123] NET: Registered PF_INET6 protocol family
[    1.790446] Segment Routing with IPv6
[    1.791936] In-situ OAM (IOAM) with IPv6
[    1.794612] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    1.802317] NET: Registered PF_PACKET protocol family
[    1.805193] Bridge firewalling registered
[    1.808848] l2tp_core: L2TP core driver, V2.0
[    1.810511] Key type dns_resolver registered
[    1.812745] NET: Registered PF_VSOCK protocol family
[    1.848437] registered taskstats version 1
[    1.873338] Key type .fscrypt registered
[    1.874652] Key type fscrypt-provisioning registered
[
DEBUG: Partial boot log:
    1.878857] Btrfs loaded, zoned=no, fsverity=no
[    1.908065] Key type encrypted registered
[    1.910859] netconsole: network logging started
[    1.946413] IP-Config: Complete:
[    1.947421]      device=eth0, hwaddr=52:54:00:12:34:06, ipaddr=192.168.7.6, mask=255.255.255.0, gw=192.168.7.5
[    1.949940]      host=192.168.7.6, domain=, nis-domain=(none)
[    1.951153]      bootserver=255.255.255.255, rootserver=255.255.255.255, rootpath=
[    1.951609]      nameserver0=8.8.8.8
[    1.956689] clk: Disabling unused clocks
[    1.958111] PM: genpd: Disabling unused power domains
[    1.962962] md: Waiting for all devices to be available before autodetect
[    1.964668] md: If you don't use raid, use raid=noautodetect
[    1.966368] md: Autodetecting RAID arrays.
[    1.967395] md: autorun ...
[    1.968111] md: ... autorun DONE.
[    1.979120] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.068059] EXT4-fs (vda): mounted filesystem e5083532-001d-4b6b-a85f-c2ad5359fe55 r/w w
DEBUG: Partial boot log:
ith ordered data mode. Quota mode: disabled.
[    2.072186] VFS: Mounted root (ext4 filesystem) on device 253:0.
[    2.076712] devtmpfs: mounted
[    2.160305] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0
[    2.167556] hid-generic 0003:0627:0001.0001: input: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:04.0-1/input0
[    2.176435] Freeing unused kernel memory: 1856K
[    2.185279] Run /sbin/init as init process
[    2.294307] usb 1-2: new high-speed USB device number 3 using xhci_hcd

DEBUG: Partial boot log:
[    2.448516] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
[    2.516143] hid-generic 0003:0627:0001.0002: input: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:04.0-2/input0

WARNING: Target didn't reach login banner in 1500 seconds (05/09/26 02:22:26)
WARNING: Last 25 lines of login console (19649):
[    1.908065] Key type encrypted registered
[    1.910859] netconsole: network logging started
[    1.946413] IP-Config: Complete:
[    1.947421]      device=eth0, hwaddr=52:54:00:12:34:06, ipaddr=192.168.7.6, mask=255.255.255.0, gw=192.168.7.5
[    1.949940]      host=192.168.7.6, domain=, nis-domain=(none)
[    1.951153]      bootserver=255.255.255.255, rootserver=255.255.255.255, rootpath=
[    1.951609]      nameserver0=8.8.8.8
[    1.956689] clk: Disabling unused clocks
[    1.958111] PM: genpd: Disabling unused power domains
[    1.962962] md: Waiting for all devices to be available before autodetect
[    1.964668] md: If you don't use raid, use raid=noautodetect
[    1.966368] md: Autodetecting RAID arrays.
[    1.967395] md: autorun ...
[    1.968111] md: ... autorun DONE.
[    1.979120] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.068059] EXT4-fs (vda): mounted filesystem e5083532-001d-4b6b-a85f-c2ad5359fe55 r/w with ordered data mode. Quota mode: disabled.
[    2.072186] VFS: Mounted root (ext4 filesystem) on device 253:0.
[    2.076712] devtmpfs: mounted
[    2.160305] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0
[    2.167556] hid-generic 0003:0627:0001.0001: input: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:04.0-1/input0
[    2.176435] Freeing unused kernel memory: 1856K
[    2.185279] Run /sbin/init as init process
[    2.294307] usb 1-2: new high-speed USB device number 3 using xhci_hcd
[    2.448516] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
[    2.516143] hid-generic 0003:0627:0001.0002: input: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:04.0-2/input0
WARNING: Last 25 lines of all logging (23900):
[    1.951609]      nameserver0=8.8.8.8
[    1.956689] clk: Disabling unused clocks
[    1.958111] PM: genpd: Disabling unused power domains
[    1.962962] md: Waiting for all devices to be available before autodetect
[    1.964668] md: If you don't use raid, use raid=noautodetect
[    1.966368] md: Autodetecting RAID arrays.
[    1.967395] md: autorun ...
[    1.968111] md: ... autorun DONE.
[    1.979120] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.068059] EXT4-fs (vda): mounted filesystem e5083532-001d-4b6b-a85f-c2ad5359fe55 r/w w
INIT: version 3.14 booting

[    2.294307] usb 1-2: new high-speed USB device number 3 using xhci_hcd
ith ordered data mode. Quota mode: disabled.
[    2.072186] VFS: Mounted root (ext4 filesystem) on device 253:0.
[    2.076712] devtmpfs: mounted
[    2.160305] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0
[    2.167556] hid-generic 0003:0627:0001.0001: input: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:04.0-1/input0
[    2.176435] Freeing unused kernel memory: 1856K
[    2.185279] Run /sbin/init as init process
[    2.294307] usb 1-2: new high-speed USB device number 3 using xhci_hcd
[    2.448516] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
[    2.516143] hid-generic 0003:0627:0001.0002: input: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:04.0-2/input0
[    2.448516] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
[    2.516143] hid-generic 0003:0627:0001.0002: input: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:04.0-2/input0
WARNING: Check full boot log: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/testimage/qemu_boot_log.20260509015705
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: 358052.24

runqemu - INFO - Removing TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4
runqemu - INFO - Removing /home/pokybuild/tmp/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576
tput: No value for $TERM and no -T specified

WARNING: Extra log data read: 

DEBUG: Sending SIGTERM to runqemu
Output from runqemu:
runqemu - INFO - Received signal: 15
runqemu - INFO - Cleaning up
runqemu - INFO - Host uptime: 358052.24

runqemu - INFO - Removing TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4
runqemu - INFO - Removing /home/pokybuild/tmp/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576
tput: No value for $TERM and no -T specified

DEBUG: Sending SIGTERM to runqemu
Output from runqemu:
runqemu - INFO - Received signal: 15
runqemu - INFO - Cleaning up
runqemu - INFO - Host uptime: 358052.24

runqemu - INFO - Removing TOPDIR/tmp/deploy/images/qemuarm64/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4
runqemu - INFO - Removing /home/pokybuild/tmp/core-image-sato-sdk-qemuarm64.rootfs-20260509014813.ext4.2556576
tput: No value for $TERM and no -T specified

ERROR: Error executing a python function in exec_func_python() autogenerated:

The stack trace of python calls that resulted in this exception/failure was:
File: 'exec_func_python() autogenerated', lineno: 2, function: <module>
     0001:
 *** 0002:do_testimage(d)
     0003:
File: '/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/classes-recipe/testimage.bbclass', lineno: 126, function: do_testimage
     0122:    dump-guest-memory {"paging":false,"protocol":"file:%s.img"}
     0123:}
     0124:
     0125:python do_testimage() {
 *** 0126:    testimage_main(d)
     0127:}
     0128:
     0129:addtask testimage
     0130:do_testimage[nostamp] = "1"
File: '/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/classes-recipe/testimage.bbclass', lineno: 379, function: testimage_main
     0375:    orig_sigterm_handler = signal.signal(signal.SIGTERM, sigterm_exception)
     0376:    try:
     0377:        # We need to check if runqemu ends unexpectedly
     0378:        # or if the worker send us a SIGTERM
 *** 0379:        tc.target.start(params=d.getVar("TEST_QEMUPARAMS"), runqemuparams=d.getVar("TEST_RUNQEMUPARAMS"))
     0380:        import threading
     0381:        try:
     0382:            threading.Timer(int(d.getVar("TEST_OVERALL_TIMEOUT")), handle_test_timeout, (int(d.getVar("TEST_OVERALL_TIMEOUT")),)).start()
     0383:        except ValueError:
File: '/srv/pokybuild/yocto-worker/pkgman-non-rpm/build/layers/openembedded-core/meta/lib/oeqa/core/target/qemu.py', lineno: 91, function: start
     0087:            except (subprocess.CalledProcessError, subprocess.TimeoutExpired, FileNotFoundError) as err:
     0088:                msg += "Error running command: %s\n%s\n" % (blcmd, err)
     0089:            msg += "\n\n===== end: snippet =====\n"
     0090:
 *** 0091:            raise RuntimeError("FAILED to start qemu - check the task log and the boot log %s" % (msg))
     0092:
     0093:    def stop(self):
     0094:        self.runner.stop()
Exception: RuntimeError: FAILED to start qemu - check the task log and the boot log 

===== start: snippet =====



===== end: snippet =====

===== start: snippet =====

file: TOPDIR/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0/testimage/qemu_boot_log.20260509015705

[    1.951609]      nameserver0=8.8.8.8
[    1.956689] clk: Disabling unused clocks
[    1.958111] PM: genpd: Disabling unused power domains
[    1.962962] md: Waiting for all devices to be available before autodetect
[    1.964668] md: If you don't use raid, use raid=noautodetect
[    1.966368] md: Autodetecting RAID arrays.
[    1.967395] md: autorun ...
[    1.968111] md: ... autorun DONE.
[    1.979120] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    2.068059] EXT4-fs (vda): mounted filesystem e5083532-001d-4b6b-a85f-c2ad5359fe55 r/w with ordered data mode. Quota mode: disabled.
[    2.072186] VFS: Mounted root (ext4 filesystem) on device 253:0.
[    2.076712] devtmpfs: mounted
[    2.160305] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input0
[    2.167556] hid-generic 0003:0627:0001.0001: input: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:04.0-1/input0
[    2.176435] Freeing unused kernel memory: 1856K
[    2.185279] Run /sbin/init as init process

INIT: version 3.14 booting

[    2.294307] usb 1-2: new high-speed USB device number 3 using xhci_hcd
[    2.448516] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:04.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input1
[    2.516143] hid-generic 0003:0627:0001.0002: input: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:04.0-2/input0


===== end: snippet =====


DEBUG: Python function do_testimage finished

Error details

Submitted on:
08/05/26 21:29
Error type:
Recipe
Task:
do_testimage
Recipe:
core-image-sato-sdk
Recipe version:
1.0-r0
Machine:
qemuarm64
Distro:
poky
Build system:
x86_64-linux
Target system:
aarch64-poky-linux
Host distro:
universal/debian-11
Branch:
master
Commit:
4f7d1a0885d7d6f2a533f7388ed5f5a35d6f99bc
Build:
#237878
Submitter:
yp-ab-debian11-vk-3
Link back:
https://autobuilder.yoctoproject.org/valkyrie/#/builders/67/builds/3763
Similar errors:
0
Open a bug