mac02: building 68kkk28lh4dwyh5fffiwnfm2xha9gap9-vm-test-ubuntu_20_04.drv Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.02 seconds) Test will time out and terminate in 3600 seconds run the VM test script additionally exposed symbols: vm, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh vm: waiting for unit multi-user.target vm: waiting for the VM to finish booting vm: starting vm vm # /nix/var/nix/builds/nix-47163-2329803204 /nix/var/nix/builds/nix-47163-2329803204/vm-state-vm vm # /nix/var/nix/builds/nix-47163-2329803204/vm-state-vm vm: QEMU running (pid 47176) vm # UEFI firmware (version edk2-stable202408-prebuilt.qemu.org built at 16:28:50 on Sep 12 2024) vm # ArmTrngLib could not be correctly initialized. vm # Error: Image at 0007FDB6000 start failed: 00000001 vm # Error: Image at 0007FD6D000 start failed: Not Found vm # Error: Image at 0007FCBA000 start failed: Unsupported vm # Error: Image at 0007FC3F000 start failed: Not Found vm # Error: Image at 0007FB65000 start failed: Aborted vm # Tpm2SubmitCommand - Tcg2 - Not Found vm # Tpm2GetCapabilityPcrs fail! vm # Tpm2SubmitCommand - Tcg2 - Not Found vm: Guest shell says: b'\x1b[2J\x1b[01;01H\x1b[=3h\x1b[2J\x1b[01;01H\x1b[2J\x1b[01;01H\x1b[=3h\x1b[2J\x1b[01;01H' vm # BdsDxe: loading Boot0001 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0) vm # BdsDxe: starting Boot0001 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0) vm: Guest shell says: b'BdsDxe: loading Boot0001 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x2,0x0)\r\nBdsDxe: starting Boot0001 "UEFI Misc Device" from Pc' vm: Guest shell says: b'iRoot(0x0)/Pci(0x2,0x0)\r\n' vm # error: no suitable video mode found. vm: Guest shell says: b'error: no suitable video mode found.\n\r' vm # -.mount vm # etc-machine\x2did.mount vm # dev-hugepages.mount vm # sys-kernel-debug.mount vm # sys-kernel-tracing.mount vm # kmod-static-nodes.service vm # dev-mqueue.mount vm # lvm2-monitor.service vm # systemd-modules-load.service vm # ufw.service vm # systemd-fsckd.service vm # sys-fs-fuse-connections.mount vm # systemd-journald.service vm # systemd-fsck-root.service vm # sys-kernel-config.mount vm # systemd-remount-fs.service vm # keyboard-setup.service vm # systemd-sysctl.service vm # systemd-random-seed.service vm # systemd-udev-trigger.service vm # systemd-journal-flush.service vm # systemd-sysusers.service vm # systemd-tmpfiles-setup-dev.service vm # systemd-udevd.service vm # proc-sys-fs-binfmt_misc.mount vm # systemd-udev-settle.service vm # multipathd.service vm # systemd-fsck@dev-disk-by\x2dlabel-UEFI.service vm # snap-lxd-32669.mount vm # snap-core20-2603.mount vm # snap-snapd-24672.mount vm # boot-efi.mount vm # console-setup.service vm # finalrd.service vm # systemd-machine-id-commit.service vm # systemd-tmpfiles-setup.service vm # Starting Network Time Synchronization... vm # Starting Update UTMP about System Boot/Shutdown... vm # [ OK ] Finished Update UTMP about System Boot/Shutdown. vm # systemd-update-utmp.service vm # [ OK ] Started Network Time Synchronization. vm # [ OK ] Reached target System Time Set. vm # [ OK ] Reached target System Time Synchronized. vm # systemd-timesyncd.service vm # apparmor.service vm # [ OK ] Finished Load AppArmor profiles. vm # Starting Load AppArmor pro…managed internally by snapd... vm # snapd.apparmor.service vm # [ OK ] Finished Load AppArmor pro…s managed internally by snapd. vm # [ 16.551891] cloud-init[544]: Cloud-init v. 24.4.1-0ubuntu0~20.04.3 running 'init-local' at Tue, 13 Oct 2026 11:58:22 +0000. Up 6.20 seconds. vm # [ 16.551974] cloud-init[544]: 2026-10-13 11:58:32,416 - url_helper.py[WARNING]: Timed out waiting for addresses: http://[fe80::a9fe:a9fe%25enp0s3]/openstack http://169.254.169.254/openstack, exception(s) raised while waiting: HTTPConnectionPool(host='fe80::a9fe:a9fe%enp0s3', port=80): Max retries exceeded with url: /openstack (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 99] Cannot assign requested address')) vm # [ 16.556316] cloud-init[544]: 2026-10-13 11:58:32,420 - log_util.py[WARNING]: No active metadata service found vm # [ OK ] Finished Cloud-init: Local Stage (pre-network). vm # [ OK ] Reached target Network (Pre). vm # cloud-init-local.service vm # Starting Network Service... vm # [ OK ] Started Network Service. vm # Starting Wait for Network to be Configured... vm # Starting Network Name Resolution... vm # systemd-networkd.service vm # [ OK ] Started Network Name Resolution. vm # [ OK ] Reached target Network. vm # [ OK ] Reached target Host and Network Name Lookups. vm # systemd-resolved.service vm # systemd-networkd-wait-online.service vm # [ OK ] Finished Wait for Network to be Configured. vm # Starting Cloud-init: Network Stage... vm # [ 28.353211] cloud-init[616]: Cloud-init v. 24.4.1-0ubuntu0~20.04.3 running 'init' at Tue, 13 Oct 2026 11:58:34 +0000. Up 18.27 seconds. vm # [ 28.353270] cloud-init[616]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++++++++++++ vm # [ 28.353679] cloud-init[616]: ci-info: +--------+------+----------------------------+---------------+--------+-------------------+ vm # [ 28.353690] cloud-init[616]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address | vm # [ 28.354060] cloud-init[616]: ci-info: +--------+------+----------------------------+---------------+--------+-------------------+ vm # [ 28.354416] cloud-init[616]: ci-info: | enp0s3 | True | 10.0.2.15 | 255.255.255.0 | global | 52:54:00:12:34:56 | vm # [ 28.354428] cloud-init[616]: ci-info: | enp0s3 | True | fe80::5054:ff:fe12:3456/64 | . | link | 52:54:00:12:34:56 | vm # [ 28.354790] cloud-init[616]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | host | . | vm # [ 28.354801] cloud-init[616]: ci-info: | lo | True | ::1/128 | . | host | . | vm # [ 28.354809] cloud-init[616]: ci-info: +--------+------+----------------------------+---------------+--------+-------------------+ vm # [ 28.355186] cloud-init[616]: ci-info: ++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++ vm # [ 28.355574] cloud-init[616]: ci-info: +-------+-------------+----------+-----------------+-----------+-------+ vm # [ 28.355911] cloud-init[616]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags | vm # [ 28.356436] cloud-init[616]: ci-info: +-------+-------------+----------+-----------------+-----------+-------+ vm # [ 28.356767] cloud-init[616]: ci-info: | 0 | 0.0.0.0 | 10.0.2.2 | 0.0.0.0 | enp0s3 | UG | vm # [ 28.357104] cloud-init[616]: ci-info: | 1 | 10.0.2.0 | 0.0.0.0 | 255.255.255.0 | enp0s3 | U | vm # [ 28.357404] cloud-init[616]: ci-info: | 2 | 10.0.2.2 | 0.0.0.0 | 255.255.255.255 | enp0s3 | UH | vm # [ 28.357417] cloud-init[616]: ci-info: +-------+-------------+----------+-----------------+-----------+-------+ vm # [ 28.357728] cloud-init[616]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++ vm # [ 28.357742] cloud-init[616]: ci-info: +-------+-------------+---------+-----------+-------+ vm # [ 28.357753] cloud-init[616]: ci-info: | Route | Destination | Gateway | Interface | Flags | vm # [ 28.357766] cloud-init[616]: ci-info: +-------+-------------+---------+-----------+-------+ vm # [ 28.358075] cloud-init[616]: ci-info: | 1 | fe80::/64 | :: | enp0s3 | U | vm # [ 28.358096] cloud-init[616]: ci-info: | 3 | local | :: | enp0s3 | U | vm # [ 28.358414] cloud-init[616]: ci-info: | 4 | multicast | :: | enp0s3 | U | vm # [ 28.358738] cloud-init[616]: ci-info: +-------+-------------+---------+-----------+-------+ vm # [ 28.359066] cloud-init[616]: 2026-10-13 11:58:44,217 - url_helper.py[WARNING]: Exception(s) [UrlError("HTTPConnectionPool(host='169.254.169.254', port=80): Max retries exceeded with url: /openstack (Caused by NewConnectionError(': Failed to establish a new connection: [Errno 101] Network is unreachable'))"), UrlError("HTTPConnectionPool(host='fe80::a9fe:a9fe%enp0s3', port=80): Max retries exceeded with url: /openstack (Caused by ConnectTimeoutError(, 'Connection to fe80::a9fe:a9fe%enp0s3 timed out. (connect timeout=10.0)'))")] during request to http://[fe80::a9fe:a9fe%25enp0s3]/openstack, raising last exception vm # [ 28.364219] cloud-init[616]: 2026-10-13 11:58:44,228 - log_util.py[WARNING]: No active metadata service found vm # [ OK ] Stopped Wait for Network to be Configured. vm # Stopping Wait for Network to be Configured... vm # Stopping Network Service... vm # [ OK ] Stopped Network Service. vm # Starting Network Service... vm # [ OK ] Started Network Service. vm # systemd-networkd.service vm # Starting Wait for Network to be Configured... vm # systemd-networkd-wait-online.service vm # [ OK ] Finished Wait for Network to be Configured. vm # [ 28.858136] cloud-init[616]: Generating public/private rsa key pair. vm # [ 28.858234] cloud-init[616]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key vm # [ 28.858513] cloud-init[616]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub vm # [ 28.858527] cloud-init[616]: The key fingerprint is: vm # [ 28.858536] cloud-init[616]: SHA256:YOptbNYKAa14eKfA8JtZHANSx/xXN1C9ljDbi67lfUg root@ubuntu vm # [ 28.858546] cloud-init[616]: The key's randomart image is: vm # [ 28.858840] cloud-init[616]: +---[RSA 3072]----+ vm # [ 28.859194] cloud-init[616]: |..oo. .o.. | vm # [ 28.859216] cloud-init[616]: | . +o . = . | vm # [ 28.859353] cloud-init[616]: |. . +.o . . * o | vm # [ 28.859361] cloud-init[616]: |o+ + =... . = | vm # [ 28.859648] cloud-init[616]: |+.= * .S o . | vm # [ 28.859850] cloud-init[616]: | + O + . . E | vm # [ 28.859978] cloud-init[616]: | = o * . ... . | vm # [ 28.859987] cloud-init[616]: | = . o... .| vm # [ 28.860164] cloud-init[616]: | . ... .. | vm # [ 28.860297] cloud-init[616]: +----[SHA256]-----+ vm # [ 28.860420] cloud-init[616]: Generating public/private ecdsa key pair. vm # [ 28.860427] cloud-init[616]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key vm # [ 28.860440] cloud-init[616]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub vm # [ 28.860484] cloud-init[616]: The key fingerprint is: vm # [ 28.860744] cloud-init[616]: SHA256:wGpFELMXhEYeNASIFALasjBr9oiVZsTflo5q0LsygTM root@ubuntu vm # [ 28.860752] cloud-init[616]: The key's randomart image is: vm # [ 28.860760] cloud-init[616]: +---[ECDSA 256]---+ vm # [ 28.860774] cloud-init[616]: |*+o=X=+ | vm # [ 28.861005] cloud-init[616]: |=o .oB . | vm # [ 28.861168] cloud-init[616]: |= +.o = | vm # [ 28.861298] cloud-init[616]: |.* o = o | vm # [ 28.861433] cloud-init[616]: |++= + + S | vm # [ 28.861565] cloud-init[616]: |E++. + | vm # [ 28.861691] cloud-init[616]: |.* o. . | vm # [ 28.861870] cloud-init[616]: |o o. | vm # [ 28.861947] cloud-init[616]: | +o. | vm # [ 28.861957] cloud-init[616]: +----[SHA256]-----+ vm # [ 28.862164] cloud-init[616]: Generating public/private ed25519 key pair. vm # [ 28.862569] cloud-init[616]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key vm # [ 28.862583] cloud-init[616]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub vm # [ 28.862822] cloud-init[616]: The key fingerprint is: vm # [ 28.862831] cloud-init[616]: SHA256:2UjbILXbxFLBIjYC6JV06LXdBmKntSUA4GlquIYSITE root@ubuntu vm # [ 28.863148] cloud-init[616]: The key's randomart image is: vm # [ 28.863155] cloud-init[616]: +--[ED25519 256]--+ vm # [ 28.863168] cloud-init[616]: |Eo+++o. ..o. | vm # [ 28.863180] cloud-init[616]: |oo.+o++*.=. | vm # [ 28.863436] cloud-init[616]: |++o ooOo@.o | vm # [ 28.863588] cloud-init[616]: |=o . o = # | vm # [ 28.863611] cloud-init[616]: |+. S + | vm # [ 28.863752] cloud-init[616]: |oo | vm # [ 28.863768] cloud-init[616]: |+. | vm # [ 28.863914] cloud-init[616]: |o | vm # [ 28.863930] cloud-init[616]: | | vm # [ 28.867090] cloud-init[616]: +----[SHA256]-----+ vm # cloud-init.service vm # [ OK ] Finished Cloud-init: Network Stage. vm # [ OK ] Reached target Cloud-config availability. vm # [ OK ] Reached target Network is Online. vm # [ OK ] Reached target System Initialization. vm # [ OK ] Started Daily apt download activities. vm # [ OK ] Started Daily apt upgrade and clean activities. vm # [ OK ] Started Periodic ext4 Onli…ata Check for All Filesystems. vm # [ OK ] Started Discard unused blocks once a week. vm # [ OK ] Started Refresh fwupd metadata regularly. vm # [ OK ] Started Daily rotation of log files. vm # [ OK ] Started Daily man-db regeneration. vm # [ OK ] Started Message of the Day. vm # [ OK ] Started Daily Cleanup of Temporary Directories. vm # [ OK ] Reached target Paths. vm # [ OK ] Reached target Timers. vm # [ OK ] Listening on cloud-init hotplug hook socket. vm # [ OK ] Listening on D-Bus System Message Bus Socket. vm # [ OK ] Listening on Open-iSCSI iscsid Socket. vm # [ OK ] Listening on UUID daemon activation socket. vm # [ OK ] Reached target Sockets. vm # [ OK ] Reached target Basic System. vm # Starting Accounts Service... vm # Starting Cloud-init: Config Stage... vm # [ OK ] Started D-Bus System Message Bus. vm # [ OK ] Started Save initial kernel messages after boot. vm # Starting Remove Stale Onli…t4 Metadata Check Snapshots... vm # Starting Record successful boot for GRUB... vm # [ OK ] Started irqbalance daemon. vm # Starting mount-store.service... vm # Starting Dispatcher daemon for systemd-networkd... vm # [ OK ] Reached target Remote File Systems (Pre). vm # [ OK ] Reached target Remote File Systems. vm # Starting LSB: automatic crash report generation... vm # Starting Deferred execution scheduler... vm # Starting Availability of block devices... vm # [ OK ] Started Regular background program processing daemon. vm # Starting Authorization Manager... vm # Starting Pollinate to seed…udo random number generator... vm # Starting System Logging Service... vm # [ OK ] Reached target Login Prompts (Pre). vm # Starting Login Service... vm # Starting Permit User Sessions... vm # Starting Disk Manager... vm # [ OK ] Started Deferred execution scheduler. vm # [ OK ] Finished mount-store.service. vm # [ OK ] Finished Availability of block devices. vm # [ OK ] Finished Permit User Sessions. vm # dbus.service vm # [ OK ] Started System Logging Service. vm # dmesg.service vm # [ OK ] Started Authorization Manager. vm # [ OK ] Started Login Service. vm # irqbalance.service vm # cron.service vm # nix-.rw\x2dstore.mount vm # nix-.ro\x2dstore.mount vm # atd.service vm # nix-store.mount vm # blk-availability.service vm # systemd-user-sessions.service vm # rsyslog.service vm # polkit.service vm # systemd-logind.service vm # [ OK ] Finished Record successful boot for GRUB. vm # [ OK ] Started Accounts Service. vm # accounts-daemon.service vm # Starting Modem Manager... vm # [ OK ] Started backdoor.service. vm # backdoor.service vm # Starting GRUB failed boot detection... vm # Starting Hold until boot process finishes up... vm # Starting Terminate Plymouth Boot Screen... vm # [ OK ] Started Unattended Upgrades Shutdown. vm # unattended-upgrades.service vm # [ OK ] Started LSB: automatic crash report generation. vm # [ OK ] Finished Hold until boot process finishes up. vm # [ OK ] Finished Terminate Plymouth Boot Screen. vm # [ OK ] Finished GRUB failed boot detection. vm # connecting to host... vm: Guest shell says: b'Spawning backdoor root shell...\n' vm: connected to guest root shell vm: (connecting took 37.19 seconds) vm: (finished: waiting for the VM to finish booting, in 37.66 seconds) vm: (finished: waiting for unit multi-user.target, in 37.67 seconds) (finished: run the VM test script, in 37.67 seconds) test script finished in 37.68s cleanup kill QemuMachine (pid 47176) vm # qemu-system-aarch64: terminating on signal 15 from pid 47173 () (finished: cleanup, in 0.01 seconds)