I built a qemu image using instructions found at (https://wiki.debian.org/ContinuousIntegration/autopkgtest):

sudo autopkgtest-build-qemu unstable /var/tmp/autopkgtest-unstable.img

Running a test with that image following instructions found at the same URL repeatedly fails with a timeout:

autopkgtest [19:42:55]: host p8h61; command line: /usr/bin/autopkgtest printer-driver-cups-pdf -- qemu --ram-size=2047 /var/tmp/autopkgtest-unstable.img
qemu-system-i386: terminating on signal 15 from pid 84626 (/usr/bin/python3)
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [19:43:55]: ERROR: testbed failure: unexpected eof from the testbed

Martin-Éric

- -- System Information:
Debian Release: trixie/sid
  APT prefers unstable
  APT policy: (500, 'unstable')
Architecture: i386 (x86_64)

Kernel: Linux 6.1.0-23-amd64 (SMP w/4 CPU threads; PREEMPT)
Locale: LANG=fi_FI.UTF-8, LC_CTYPE=fi_FI.UTF-8 (charmap=UTF-8), LANGUAGE=fi:en
Shell: /bin/sh linked to /usr/bin/dash
Init: unable to detect

Versions of packages autopkgtest depends on:
ii  apt-utils       2.9.7
ii  libdpkg-perl    1.22.10
ii  mawk            1.3.4.20240622-2
ii  procps          2:4.0.4-5
ii  python3         3.12.4-1
ii  python3-debian  0.1.49

Versions of packages autopkgtest recommends:
ii  autodep8  0.28+nmu1
ii  fakeroot  1.35.1-1

Versions of packages autopkgtest suggests:
pn  docker.io            <none>
pn  fakemachine          <none>
pn  genisoimage          <none>
pn  incus                <none>
pn  lxc                  <none>
pn  lxd                  <none>
pn  ovmf                 <none>
pn  ovmf-ia32            <none>
pn  podman               <none>
ii  python3-distro-info  1.7
pn  qemu-efi-aarch64     <none>
pn  qemu-efi-arm         <none>
pn  qemu-efi-riscv64     <none>
pn  qemu-system          <none>
ii  qemu-utils           1:9.0.2+ds-1
pn  schroot              <none>
ii  util-linux           2.40.2-1
ii  vmdb2                0.40-1
pn  zerofree             <none>

- -- no debconf information
-----BEGIN PGP SIGNATURE-----

iQIzBAEBCgAdFiEEyJACx3qL7GpObXOQrh+Cd8S017YFAmapHfcACgkQrh+Cd8S0
17YXDQ/9GxUGSimaA/ua9RRWgycjjwNmieKYkAi7BXluQKvZ3/ZOQJuZW+GhDNK4
XFVRaFtzkmvarONnm9wezFXluvAlPWj1ULpaNrSNnqg9fjN6MWe6AUpXuMdGafCz
tRRbo6KSPMpHNQsl3zaGnROLf93akSr+RO3o8AjItKwOd1EtQrtpS/pFX9lkrOZF
Nym+vOrAup19QIlzluWNJZL+V/y5UVzkBJmIuJWGAhtKJBB8aFeXg4DRpSrV9Ksy
b3ZkGJ6gmyLZnvB5+f9Jp+FdH7qyIiJ9Br/P08CYyYSZc2QLKce+kj4y1FN8ir+u
/Ew1i0veGe+qaiKjnMm5Zx7nEAbwU4VGrkNKf7tLbMobKqBl5zhnJPCP7gyYysHs
X6Vh95GvUPCXNkuCZWFQx1eWklpnRXhRH50FXw1BUOWdWH2rBSaGrrwWwr+rUxrt
UQQocznFW7NzMUHw4bN6J+gfp5vNkoj84jTAL+WY3T+U1hsWvS/tQiOKXMF7MWEL
2/pwzmyZSwev93EOB9eFP7hWJAfa26z5Vy3D761NnthYLHpVmdjB4htDMhjv0jSM
FntP+3T9uSPsj0ODcXqUFW0lUENVC3oFvlohyMwxD+Ph0dJIAszCdUXg6mLI/eAm
feaQlDdi7nSdqieqY0yKMyexdndwNCzhSQjzczGdxEJJ3wvmFiw=
=9XWx
-----END PGP SIGNATURE-----

Hi

This is linux kernel bug 1071456.

Paul

ti 30. heinäk. 2024 klo 20.17 Paul Gevers (elbrus@debian.org) kirjoitti:

Ouch. Nice one.
Awaiting fix.

Martin-Éric

We believe that the bug you reported is fixed in the latest version of
autopkgtest, which is due to be installed in the Debian FTP archive.

A summary of the changes between this version and the previous one is
attached.

Thank you for reporting the bug, which will now be closed.  If you
have further comments please address them to 1071456@bugs.debian.org,
and the maintainer will reopen the bug report if appropriate.

Debian distribution maintenance software
pp.
Simon McVittie <smcv@debian.org> (supplier of updated autopkgtest package)

(This message was generated automatically at their request; if you
believe that there is a problem with it please contact the archive
administrators by mailing ftpmaster@ftp-master.debian.org)
Format: 1.8
Date: Mon, 12 Aug 2024 12:11:05 +0100
Source: autopkgtest
Architecture: source
Version: 5.39
Distribution: unstable
Urgency: medium
Maintainer: Debian CI team <team+ci@tracker.debian.org>
Changed-By: Simon McVittie <smcv@debian.org>
Closes: 1021776 1034351 1039958 1071456 1076739 1077988 1078076 1078214 1078215 1078216 1078510
Changes:
 autopkgtest (5.39) unstable; urgency=medium
 .
   [ Paride Legovini ]
   * d/tests/lxd: drop racey workaround for the images: remote url,
     depend on a new enough lxd instead (Closes: #1078216)
   * d/control: bump Standards-Version to 4.7.0, no changes needed
   * Drop --testname argument, deprecated in 2017
   * a-v-unshare: create user with useradd --prefix instead of --root,
     to avoid chrooting into an environment that does not yet have /dev
     (Closes: #1077988)
   * Stop skipping d/t/unshare on Ubuntu, no longer necessary with the
     above a-v-unshare change
   * d/t/unshare: run tests in an Ubuntu testbed when host system is Ubuntu
 .
   [ Ural Tunaboyu ]
   * autopkgtest-buildvm-ubuntu-cloud: improve dependency checks
     (LP: #2073938)
 .
   [ Simon McVittie ]
   * virt-qemu: Work around #1072004 in 9pfs.
     Thanks to Dominique Martinet (Closes: #1071456) (Mitigates: #1072004)
   * build-podman: Don't assume that host is reachable as 10.0.2.2,
     which is no longer true when podman uses passt (Closes: #1078076)
   * qemu: Refactor to allow detection of dependencies
   * qemu: Update lists of architectures (Helps: #1062026)
   * build-*, virt-qemu, virt-docker/virt-podman, virt-lxc,
     virt-lxd/virt-incus: Check for (most) dependencies
     (Closes: #1021776, #1034351, #1039958, #1076739)
   * build-docker/build-podman, build-qemu: Fix running from source tree
   * tests: Skip tests involving mount points if we don't have
     CAP_SYS_ADMIN, for example in rootless podman (Closes: #1078215)
   * d/README.source: Mention the minimum Python version in testbeds (3.4)
   * d/control, d/tests/control: /usr/bin/docker is now in docker-cli
     (see also #1078269)
   * d/tests/control: Install passt along with newer podman versions
   * tests: Use a Debian mirror to test handling of persistent apt failures
 .
   [ Jochen Sprickerhof ]
   * unshare: Make the chroot more minimal (mmdebstrap --variant=apt)
 .
   [ Luca Boccassi ]
   * await-boot.sh: Make the check for systemd-sysv robust against tests
     that install a different init system (Closes: #1078510)
 .
   [ Paul Gevers ]
   * wrapper.sh: Convert test exit codes 254 and 255 to 253, preventing
     misinterpretation as a testbed failure (Closes: #1078214)
 .
   [ Johannes Schauer Marin Rodrigues ]
   * doc/README.package-tests.rst: Use a better example test name
   * doc/README.package-tests.rst: A test name cannot contain commas
Checksums-Sha1:
 d95ae41a23727a92d62f4b639fbc977950e68619 2586 autopkgtest_5.39.dsc
 4ada280e786d948bf6ffab543a9fba49b8c64af8 229780 autopkgtest_5.39.tar.xz
 3e607a6766eba3d6d78a35f943f29dcddda90f08 6511 autopkgtest_5.39_source.buildinfo
Checksums-Sha256:
 ea9394fd443e57e691a4beecffc9c3e09f3a052db6dc4a1f36f5d5f478c75246 2586 autopkgtest_5.39.dsc
 5cdf6125ddd176fabe68527f2f7a10b83019ddc1a6fbbeb072018f39ecd2f1d1 229780 autopkgtest_5.39.tar.xz
 15c7fa23549faff844695ec6cff74843558e6c3831e2eaaf1a3ee161cc4efe64 6511 autopkgtest_5.39_source.buildinfo
Files:
 27460950a7a1ffe6e41c1cd08ecd3ae2 2586 devel optional autopkgtest_5.39.dsc
 cb89b529abb1e15503c747862c44c05e 229780 devel optional autopkgtest_5.39.tar.xz
 759c587e65c31b9d3bb0d81df4de2f0c 6511 devel optional autopkgtest_5.39_source.buildinfo
-----BEGIN PGP SIGNATURE-----

iQIzBAEBCAAdFiEENuxaZEik9e95vv6Y4FrhR4+BTE8FAma6NqgACgkQ4FrhR4+B
TE83eRAAttbKvlQSLMx2Gj3mtYA1PPcE2gL23FxEmRAb3UpstQbNZnQc+m2nJA4/
F41DLPauKWdzygcsTzgV2XAOaHPYHW3JByj5uQr6uUR2XaNl+AEMr+NSIBev7eW3
LX9OOvK/OEdPNonUApVGoc+BcImPuXxMyzVExTeqtAkN6I8hJ7iD8im12iWvXcxB
QCaH6Q1KIhYVzJMZN6ENtkH3HQ8mCFXitWS64Gso/AJpxi0kFqRmJEQf1WBttbl3
ndHVP/pwpaTppubwaFFmUtyLdP6TxO7Up40aszXGzjkaQOUYd7YsTeQFwcjE8D+W
7ECRDqYIPHxEVX7DfaDV8QzU23KydUGPttUd3fMAOF/Jf4SIltdbppKNYPXkGEyu
zCe+A1y36F2M1lsd/s6BE8j1hPjf/RWfzBptuKzldtD6VbLrA+l6HvIFLJjhs8qE
Z56EM4UYm76DkYb6nEt1Ydp0o+OT3mnTCFcl4PJBWzd3FOpYwmRoUhXK9nV/ic/0
i9Ov9/auyrYqARplXfwB11ygkfV7e5BBsWv5d6SgbWe13s+2bgQmwZ1ENWJugQgr
dBv5svagxvo+/3qmQUe03nfkv4f8qZkRfLaiFqmcHqZM2qEKaadPMXG/OYx+fR1O
mp3aOfqpdcsb9Osgll6IfKYBWSGGs9UbPwAPZHrMY7lZ9DwMm4E=
=f9Su
-----END PGP SIGNATURE-----

Sorry, this did not fix it.

I created a fresh image as follow:

sudo autopkgtest-build-qemu unstable /var/tmp/autopkgtest-unstable.img

I then tried to launch a test as follow:

$ autopkgtest dhcpcd -- qemu --ram-size 2047 /var/tmp/autopkgtest-unstable.img
autopkgtest [23:12:05]: starting date and time: 2024-08-12 23:12:05+0300
autopkgtest [23:12:05]: version 5.39
autopkgtest [23:12:05]: host p8h61; command line: /usr/bin/autopkgtest
dhcpcd -- qemu --ram-size 2047 /var/tmp/autopkgtest-unstable.img
qemu-system-i386: terminating on signal 15 from pid 34522 (/usr/bin/python3)
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [23:13:06]: ERROR: testbed failure: unexpected eof from the testbed

Martin-Éric

Control: unmerge 1071456 1077620
Control: retitle 1077620 autopkgtest-virt-qemu: timed out waiting for 'login prompt on serial console'
Control: reopen 1077620
Control: tags 1077620 + moreinfo
...

I think this must be a different failure mode than the 9pfs bug that
caused #1071456, then. A similar setup is working well for me, on unstable,
but I was getting similar timeouts intermittently in the past.

Adding --debug and/or --show-boot after qemu on the command line might
provide useful information?

I wonder whether it's significant that you seem to be using an i386
user-space on an amd64 kernel. (Intentionally?)

    smcv

ti 13. elok. 2024 klo 0.49 Simon McVittie (smcv@debian.org) kirjoitti:

Agreed.

DEBUG

$ autopkgtest dhcpcd -- qemu --debug --ram-size 2047
/var/tmp/autopkgtest-unstable.img
autopkgtest [08:09:22]: starting date and time: 2024-08-13 08:09:22+0300
autopkgtest [08:09:22]: version 5.39
autopkgtest [08:09:22]: host p8h61; command line: /usr/bin/autopkgtest
dhcpcd -- qemu --debug --ram-size 2047
/var/tmp/autopkgtest-unstable.img
autopkgtest-virt-qemu: DBG: Assuming nothing special needs to be done
to set up firmware to boot this machine (boot method: bios)
autopkgtest-virt-qemu: DBG: executing open
autopkgtest-virt-qemu: DBG: qemu architecture: i386
autopkgtest-virt-qemu: DBG: qemu command: qemu-system-i386
autopkgtest-virt-qemu: DBG: find_free_port: trying 10022
autopkgtest-virt-qemu: DBG: find_free_port: 10022 is free
autopkgtest-virt-qemu: DBG: execute-timeout: qemu-img info
--output=json /var/tmp/autopkgtest-unstable.img
autopkgtest-virt-qemu: DBG: Creating temporary overlay image in
/tmp/autopkgtest-qemu.6hxz4sjo/overlay.img
autopkgtest-virt-qemu: DBG: execute-timeout: qemu-img create -f qcow2
-F qcow2 -b /var/tmp/autopkgtest-unstable.img
/tmp/autopkgtest-qemu.6hxz4sjo/overlay.img
autopkgtest-virt-qemu: DBG: Forwarding local port 10022 to VM ssh port 22
autopkgtest-virt-qemu: DBG: full qemu command-line:
['qemu-system-i386', '-m', '2047', '-smp', '1', '-nographic',
'-device', 'virtio-net-pci,netdev=net0', '-netdev',
'user,id=net0,hostfwd=tcp:127.0.0.1:10022-:22', '-object',
'rng-random,filename=/dev/urandom,id=rng0', '-device',
'virtio-rng-pci,rng=rng0,id=rng-device0', '-monitor',
'unix:/tmp/autopkgtest-qemu.6hxz4sjo/monitor,server=on,wait=off',
'-virtfs', 'local,id=autopkgtest,path=/tmp/autopkgtest-qemu.6hxz4sjo/shared,security_model=none,mount_tag=autopkgtest',
'-device', 'virtio-serial', '-chardev',
'socket,path=/tmp/autopkgtest-qemu.6hxz4sjo/hvc0,server=on,wait=off,id=hvc0',
'-device', 'virtconsole,chardev=hvc0', '-chardev',
'socket,path=/tmp/autopkgtest-qemu.6hxz4sjo/hvc1,server=on,wait=off,id=hvc1',
'-device', 'virtconsole,chardev=hvc1', '-serial',
'unix:/tmp/autopkgtest-qemu.6hxz4sjo/ttyS0,server=on,wait=off',
'-serial', 'unix:/tmp/autopkgtest-qemu.6hxz4sjo/ttyS1,server=on,wait=off',
'-drive', 'index=0,file=/tmp/autopkgtest-qemu.6hxz4sjo/overlay.img,format=qcow2,cache=unsafe,if=virtio,discard=unmap']
autopkgtest-virt-qemu: DBG: expect: b' login: '
qemu-system-i386: terminating on signal 15 from pid 51363 (/usr/bin/python3)
autopkgtest-virt-qemu: DBG: cleanup...
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [08:10:22]: ERROR: testbed failure: unexpected eof from the testbed

SHOW-BOOT
[...kernel boots...]
[   23.298592] systemd[1]: systemd 256.4-3 running in system mode
(+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS
+OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD
+LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY
+P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK
-XKBCOMMON +UTMP +SYSVINIT +LIBARCHIVE)
[   23.301172] systemd[1]: Detected virtualization qemu.
[   23.302473] systemd[1]: Detected architecture x86.

Welcome to Debian GNU/Linux trixie/sid!

[   23.324735] systemd[1]: Hostname set to <host>.
[   27.687764] systemd[1]: Queued start job for default target graphical.target.
[   28.042777] systemd[1]: Created slice system-autopkgtest.slice -
Slice /system/autopkgtest.
[  OK  ] Created slice system-autopkgtest.slice - Slice /system/autopkgtest.
[   28.076237] systemd[1]: Created slice system-getty.slice - Slice
/system/getty.
[  OK  ] Created slice system-getty.slice - Slice /system/getty.
[   28.091706] systemd[1]: Created slice system-modprobe.slice - Slice
/system/modprobe.
[  OK  ] Created slice system-modprobe.slice - Slice /system/modprobe.
[   28.107356] systemd[1]: Created slice system-serial\x2dgetty.slice
- Slice /system/serial-getty.
[  OK  ] Created slice system-serial\x2dget…slice - Slice /system/serial-getty.
[   28.120775] systemd[1]: Created slice user.slice - User and Session Slice.
[  OK  ] Created slice user.slice - User and Session Slice.
[   28.129581] systemd[1]: Started systemd-ask-password-console.path -
Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started systemd-ask-password-conso…equests to Console Directory Watch.
[   28.135185] systemd[1]: Started systemd-ask-password-wall.path -
Forward Password Requests to Wall Directory Watch.
[  OK  ] Started systemd-ask-password-wall.…d Requests to Wall Directory Watch.
[   28.159271] systemd[1]: Set up automount
proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats
File System Automount Point.
[  OK  ] Set up automount proc-sys-fs-binfm…ormats File System Automount Point.
[   28.164593] systemd[1]: Expecting device dev-hvc0.device - /dev/hvc0...
         Expecting device dev-hvc0.device - /dev/hvc0...
[   28.167542] systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
         Expecting device dev-ttyS0.device - /dev/ttyS0...
[   28.170836] systemd[1]: Reached target paths.target - Path Units.
[  OK  ] Reached target paths.target - Path Units.
[   28.173624] systemd[1]: Reached target remote-fs.target - Remote
File Systems.
[  OK  ] Reached target remote-fs.target - Remote File Systems.
[   28.176393] systemd[1]: Reached target slices.target - Slice Units.
[  OK  ] Reached target slices.target - Slice Units.
[   28.178986] systemd[1]: Reached target swap.target - Swaps.
[  OK  ] Reached target swap.target - Swaps.
[   28.234599] systemd[1]: Listening on systemd-creds.socket -
Credential Encryption/Decryption.
[  OK  ] Listening on systemd-creds.socket - Credential Encryption/Decryption.
[   28.242812] systemd[1]: Listening on systemd-initctl.socket -
initctl Compatibility Named Pipe.
[  OK  ] Listening on systemd-initctl.socke…- initctl Compatibility Named Pipe.
[   28.250347] systemd[1]: Listening on
systemd-journald-dev-log.socket - Journal Socket (/dev/log).
[  OK  ] Listening on systemd-journald-dev-…socket - Journal Socket (/dev/log).
[   28.257349] systemd[1]: Listening on systemd-journald.socket -
Journal Sockets.
[  OK  ] Listening on systemd-journald.socket - Journal Sockets.
[   28.261731] systemd[1]: systemd-pcrextend.socket - TPM PCR
Measurements was skipped because of an unmet condition check
(ConditionSecurity=measured-uki).
[   28.263815] systemd[1]: systemd-pcrlock.socket - Make TPM PCR
Policy was skipped because of an unmet condition check
(ConditionSecurity=measured-uki).
[   28.269696] systemd[1]: Listening on systemd-udevd-control.socket -
udev Control Socket.
[  OK  ] Listening on systemd-udevd-control.socket - udev Control Socket.
[   28.276616] systemd[1]: Listening on systemd-udevd-kernel.socket -
udev Kernel Socket.
[  OK  ] Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
[   28.517295] systemd[1]: Mounting dev-hugepages.mount - Huge Pages
File System...
         Mounting dev-hugepages.mount - Huge Pages File System...
[   28.923612] systemd[1]: Mounting dev-mqueue.mount - POSIX Message
Queue File System...
         Mounting dev-mqueue.mount - POSIX Message Queue File System...
[   29.028752] systemd[1]: Mounting run-lock.mount - Legacy Locks
Directory /run/lock...
         Mounting run-lock.mount - Legacy Locks Directory /run/lock...
[   29.236684] systemd[1]: Mounting sys-kernel-debug.mount - Kernel
Debug File System...
         Mounting sys-kernel-debug.mount - Kernel Debug File System...
[   29.404613] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel
Trace File System...
         Mounting sys-kernel-tracing.mount - Kernel Trace File System...
[   29.584836] systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
         Mounting tmp.mount - Temporary Directory /tmp...
[   30.076851] systemd[1]: Starting kmod-static-nodes.service - Create
List of Static Device Nodes...
         Starting kmod-static-nodes.service…eate List of Static Device Nodes...
[   30.197191] systemd[1]: Starting modprobe@configfs.service - Load
Kernel Module configfs...
         Starting modprobe@configfs.service - Load Kernel Module configfs...
[   30.362710] systemd[1]: Starting modprobe@drm.service - Load Kernel
Module drm...
         Starting modprobe@drm.service - Load Kernel Module drm...
[   30.526517] systemd[1]: Starting modprobe@efi_pstore.service - Load
Kernel Module efi_pstore...
         Starting modprobe@efi_pstore.servi… - Load Kernel Module efi_pstore...
[   30.662330] systemd[1]: Starting modprobe@fuse.service - Load
Kernel Module fuse...
         Starting modprobe@fuse.service - Load Kernel Module fuse...
[   30.680459] systemd[1]: systemd-fsck-root.service - File System
Check on Root Device was skipped because of an unmet condition check
(ConditionPathExists=!/run/initramfs/fsck-root).
[   30.708765] systemd[1]: systemd-hibernate-clear.service - Clear
Stale Hibernate Storage Info was skipped because of an unmet condition
check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
[   31.319311] systemd[1]: Starting systemd-journald.service - Journal
Service...
         Starting systemd-journald.service - Journal Service...
[   31.624809] systemd[1]: Starting systemd-modules-load.service -
Load Kernel Modules...
         Starting systemd-modules-load.service - Load Kernel Modules...
[   31.674910] systemd[1]: systemd-pcrmachine.service - TPM PCR
Machine ID Measurement was skipped because of an unmet condition check
(ConditionSecurity=measured-uki).
[   32.061523] systemd[1]: Starting systemd-remount-fs.service -
Remount Root and Kernel File Systems...
         Starting systemd-remount-fs.servic…unt Root and Kernel File Systems...
[   32.107257] systemd[1]: systemd-tpm2-setup-early.service - Early
TPM SRK Setup was skipped because of an unmet condition check
(ConditionSecurity=measured-uki).
[   32.184304] ACPI: bus type drm_connector registered
[   32.337811] systemd[1]: Starting
systemd-udev-load-credentials.service - Load udev Rules from
Credentials...
         Starting systemd-udev-load-credent…Load udev Rules from Credentials...
[   32.473010] systemd[1]: Starting systemd-udev-trigger.service -
Coldplug All udev Devices...
         Starting systemd-udev-trigger.service - Coldplug All udev Devices...
[   34.091330] EXT4-fs (vda1): re-mounted
e02d0b35-b025-4498-90d2-885a755bb73f r/w. Quota mode: none.
[   34.272090] systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
[  OK  ] Mounted dev-hugepages.mount - Huge Pages File System.
[   34.352830] systemd[1]: Mounted dev-mqueue.mount - POSIX Message
Queue File System.
[  OK  ] Mounted dev-mqueue.mount - POSIX Message Queue File System.
[   34.375954] systemd[1]: Mounted run-lock.mount - Legacy Locks
Directory /run/lock.
[  OK  ] Mounted run-lock.mount - Legacy Locks Directory /run/lock.
[   34.399120] systemd[1]: Mounted sys-kernel-debug.mount - Kernel
Debug File System.
[  OK  ] Mounted sys-kernel-debug.mount - Kernel Debug File System.
[   34.422639] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel
Trace File System.
[  OK  ] Mounted sys-kernel-tracing.mount - Kernel Trace File System.
[   34.438417] systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
[  OK  ] Mounted tmp.mount - Temporary Directory /tmp.
[   34.506772] systemd[1]: Finished kmod-static-nodes.service - Create
List of Static Device Nodes.
[  OK  ] Finished kmod-static-nodes.service…Create List of Static Device Nodes.
[   34.596942] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[   34.624716] systemd[1]: Finished modprobe@configfs.service - Load
Kernel Module configfs.
[  OK  ] Finished modprobe@configfs.service - Load Kernel Module configfs.
[   34.688717] systemd[1]: modprobe@drm.service: Deactivated successfully.
[   34.696397] systemd-journald[211]: Collecting audit messages is disabled.
[   34.716329] systemd[1]: Finished modprobe@drm.service - Load Kernel
Module drm.
[  OK  ] Finished modprobe@drm.service - Load Kernel Module drm.
[   34.766073] systemd[1]: modprobe@efi_pstore.service: Deactivated
successfully.
[   34.787534] systemd[1]: Finished modprobe@efi_pstore.service - Load
Kernel Module efi_pstore.
[  OK  ] Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
[   34.831297] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[   34.855336] systemd[1]: Finished modprobe@fuse.service - Load
Kernel Module fuse.
[  OK  ] Finished modprobe@fuse.service - Load Kernel Module fuse.
[   34.892746] systemd[1]: Finished systemd-modules-load.service -
Load Kernel Modules.
[  OK  ] Finished systemd-modules-load.service - Load Kernel Modules.
[   34.934936] systemd[1]: Finished systemd-remount-fs.service -
Remount Root and Kernel File Systems.
[  OK  ] Finished systemd-remount-fs.servic…mount Root and Kernel File Systems.
[   35.283016] systemd[1]: Finished
systemd-udev-load-credentials.service - Load udev Rules from
Credentials.
[  OK  ] Finished systemd-udev-load-credent…- Load udev Rules from Credentials.
[   35.960190] systemd[1]: Mounting sys-fs-fuse-connections.mount -
FUSE Control File System...
         Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
[   36.155479] systemd[1]: Mounting sys-kernel-config.mount - Kernel
Configuration File System...
         Mounting sys-kernel-config.mount - Kernel Configuration File System...
[   36.315805] systemd[1]: systemd-hwdb-update.service - Rebuild
Hardware Database was skipped because no trigger condition checks were
met.
[   36.364014] systemd[1]: systemd-pstore.service - Platform
Persistent Storage Archival was skipped because of an unmet condition
check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
[   36.700254] systemd[1]: Starting systemd-random-seed.service -
Load/Save OS Random Seed...
         Starting systemd-random-seed.service - Load/Save OS Random Seed...
[   37.021092] systemd[1]: Starting systemd-sysctl.service - Apply
Kernel Variables...
         Starting systemd-sysctl.service - Apply Kernel Variables...
[   37.436952] systemd[1]: Starting
systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes
in /dev gracefully...
         Starting systemd-tmpfiles-setup-de… Device Nodes in /dev gracefully...
[   37.535000] systemd[1]: systemd-tpm2-setup.service - TPM SRK Setup
was skipped because of an unmet condition check
(ConditionSecurity=measured-uki).
[   38.258771] systemd[1]: Started systemd-journald.service - Journal Service.
[  OK  ] Started systemd-journald.service - Journal Service.
[  OK  ] Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
[  OK  ] Mounted sys-kernel-config.mount - Kernel Configuration File System.
[  OK  ] Finished systemd-random-seed.service - Load/Save OS Random Seed.
[  OK  ] Finished systemd-sysctl.service - Apply Kernel Variables.
         Starting systemd-journal-flush.ser…sh Journal to Persistent Storage...
[  OK  ] Finished systemd-tmpfiles-setup-de…ic Device Nodes in /dev gracefully.
         Starting systemd-sysusers.service - Create System Users...
[   43.198991] systemd-journald[211]: Received client request to flush
runtime journal.
[  OK  ] Finished systemd-sysusers.service - Create System Users.
         Starting systemd-tmpfiles-setup-de…eate Static Device Nodes in /dev...
[  OK  ] Finished systemd-journal-flush.ser…lush Journal to Persistent Storage.
[  OK  ] Finished systemd-tmpfiles-setup-de…Create Static Device Nodes in /dev.
[  OK  ] Reached target local-fs-pre.target…Preparation for Local File Systems.
[  OK  ] Reached target local-fs.target - Local File Systems.
[  OK  ] Listening on systemd-sysext.socket… System Extension Image Management.
         Starting apparmor.service - Load AppArmor profiles...
       qemu-system-i386: terminating on signal 15 from pid 51545
(/usr/bin/python3)
  Starting ldconfig.service - Rebuild Dynamic Linker Cache...
         Starting systemd-binfmt.service - Set Up Additional Binary Formats...
         Starting systemd-tmpfiles-setup.se…ate System Files and Directories...
         Starting systemd-udevd.service - R…ager for Device Events and Files...
[  OK  ] Finished systemd-udev-trigger.service - Coldplug All udev Devices.
[  OK  ] Finished ldconfig.service - Rebuild Dynamic Linker Cache.
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [08:13:00]: ERROR: testbed failure: unexpected eof from the testbed

Possible. t64 issue creeping in?

Martin-Éric

Es gibt eine Familienspende in Höhe von 1.850.000,00 USD von Cheng Charlie
Saephan. Bitte antworten Sie für weitere Informationen. Denken Sie daran,
Ihrer Familie und den Bedürftigen in Ihrer Umgebung Gutes zu tun.

Dies ist bereits der zweite Versuch, Sie zu erreichen. Bitte antworten Sie
für weitere Details.

Es gibt eine Familienspende in Höhe von 1.850.000,00 USD von Cheng Charlie
Saephan. Bitte antworten Sie für weitere Informationen. Denken Sie daran,
Ihrer Familie und den Bedürftigen in Ihrer Umgebung Gutes zu tun.

Dies ist bereits der zweite Versuch, Sie zu erreichen. Bitte antworten Sie
für weitere Details.

On Tue, 13 Aug 2024 08:17:30 +0300 =?UTF-8?Q?Martin=2D=C3=89ric_Racine?= <martin-eric.racine@iki.fi> wrote:

$ autopkgtest ../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade -- qemu
/var/tmp/debian-unstable.img
autopkgtest [17:05:14]: starting date and time: 2026-05-01 17:05:14+0300
autopkgtest [17:05:14]: version 5.55
autopkgtest [17:05:14]: host p8b75; command line: /usr/bin/autopkgtest
../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade -- qemu
/var/tmp/debian-unstable.img
qemu-system-x86_64: terminating on signal 15 from pid 569825 (/usr/bin/python3)
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [17:06:15]: ERROR: testbed failure: eof from the
virtualisation server
Exception ignored in: <_io.TextIOWrapper name=5 encoding='UTF-8'>
BrokenPipeError: [Errno 32] Broken pipe
[2026-05-01 17:06](UNSTABLE CHROOT
amd64)perkelix@p8b75:~/Projects/Salsa/dhcpcd$ autopkgtest
../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade --debug -- qemu
/var/tmp/debian-unstable.img
autopkgtest: DBG: autopkgtest options:
Namespace(override_control=None, only_tests=[], skip_tests=None,
built_binaries=True, test_architecture=None,
packages=['../dhcpcd_10.3.2-2_amd64.changes'], output_dir=None,
logfile=None, summary=None, verbosity=2, setup_commands=[],
apt_upgrade=True, setup_commands_boot=[], add_apt_sources=[],
add_apt_releases=[], pin_packages=[], apt_pocket=[],
apt_default_release=None, enable_apt_fallback=True, copy=[], env=[],
ignore_restrictions=[], insecure=False, user=None, gainroot=None,
shell_fail=False, shell=False, timeout=0, timeout_short=None,
timeout_copy=None, timeout_install=None, timeout_test=None,
timeout_build=None, timeout_factor=1.0, set_lang=None,
auto_control=True, build_parallel=None, needs_internet='run',
validate=False)
autopkgtest: DBG: virt-runner arguments: ['qemu',
'/var/tmp/debian-unstable.img']
autopkgtest: DBG: actions: [('binary',
'../dhcpcd-base-dbgsym_10.3.2-2_amd64.deb', None), ('binary',
'../dhcpcd-base_10.3.2-2_amd64.deb', None), ('binary',
'../dhcpcd5_10.3.2-2_all.deb', None), ('binary',
'../dhcpcd_10.3.2-2_all.deb', None), ('source',
'../dhcpcd_10.3.2-2.dsc', False)]
autopkgtest: DBG: build binaries: False
autopkgtest: DBG: testbed init
autopkgtest [17:10:08]: starting date and time: 2026-05-01 17:10:08+0300
autopkgtest [17:10:08]: version 5.55
autopkgtest [17:10:08]: host p8b75; command line: /usr/bin/autopkgtest
../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade --debug -- qemu
/var/tmp/debian-unstable.img
autopkgtest: DBG: got reply from testbed: ok
autopkgtest: DBG: testbed open, scratch=None
autopkgtest: DBG: sending command to virtualisation server: open
qemu-system-x86_64: terminating on signal 15 from pid 570734 (/usr/bin/python3)
<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest: DBG: sending command to virtualisation server: auxverb_debug_fail
autopkgtest: DBG: TestbedFailure cannot send to virtualisation server:
[Errno 32] Broken pipe
autopkgtest: DBG: testbed stop
autopkgtest: DBG: testbed close, scratch=None
autopkgtest: DBG: sending command to virtualisation server: quit
autopkgtest: DBG: TestbedFailure cannot send to virtualisation server:
[Errno 32] Broken pipe
autopkgtest: DBG: testbed stop
autopkgtest: DBG: auxverb_debug_fail failed: cannot send to
virtualisation server: [Errno 32] Broken pipe
autopkgtest: DBG: TestbedFailure eof from the virtualisation server
autopkgtest: DBG: testbed stop
autopkgtest [17:11:08]: ERROR: testbed failure: eof from the
virtualisation server
autopkgtest: DBG: testbed stop
Exception ignored in: <_io.TextIOWrapper name=5 encoding='UTF-8'>
BrokenPipeError: [Errno 32] Broken pipe

Best Regards,
Martin-Éric

On Fri, 1 May 2026 17:14:43 +0300 =?UTF-8?Q?Martin=2D=C3=89ric_Racine?= <martin-eric.racine@iki.fi> wrote:
[...]

8X-----
$ autopkgtest ../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade -- qemu
--show-boot /var/tmp/debian-unstable.img
[...]
[  OK  ] Reached target initrd-switch-root.target - Switch Root.
         Starting initrd-switch-root.service - Switch Root...
[   49.495484] systemd-journald[204]: Received SIGTERM from PID 1 (systemd).
[   50.459492] random: crng init done
[   50.566548] NET: Registered PF_VSOCK protocol family
[   51.535684] systemd[1]: systemd 260.1-1 running in system mode
(+PAM +AUDIT +SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT
-GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD
+LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY
+P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK
+BTF -XKBCOMMON -UTMP +LIBARCHIVE)
[   51.541980] systemd[1]: Detected virtualization qemu.
[   51.545370] systemd[1]: Detected architecture x86-64.

Welcome to Debian
GNU/Lin^[[8;53;211t^[[53;1R^[[53;211Rqemu-system-x86_64: terminating
on signal 15 from pid 572038 (/usr/bin/python3)
ux forky/sid!

<VirtSubproc>: failure: timed out waiting for 'login prompt on serial console'
autopkgtest [17:17:50]: ERROR: testbed failure: eof from the
virtualisation server
Exception ignored in: <_io.TextIOWrapper name=5 encoding='UTF-8'>
BrokenPipeError: [Errno 32] Broken pipe
8X-----

Martin-Éric

On Fri, 1 May 2026 17:22:06 +0300 =?UTF-8?Q?Martin=2D=C3=89ric_Racine?= <martin-eric.racine@iki.fi> wrote:

Just to recap what I did:

$ sudo autopkgtest-build-qemu unstable /var/tmp/debian-unstable.img
http://deb.debian.org/debian amd64
$ autopkgtest ../dhcpcd_10.3.2-2_amd64.changes --apt-upgrade -- qemu
/var/tmp/debian-unstable.img

Still affects version 5.55 of autopkgtest.

Martin-Éric