Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: machine1, machine2, 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 start all VMs machine1: systemd-nspawn running (pid 52) machine2: systemd-nspawn running (pid 53) machine1: Waiting for journal at /build/vm-state-machine1/var/log/journal... machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal... (finished: start all VMs, in 0.00 seconds) machine1: must succeed: systemctl status sshd nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE nixos-nspawn(machine1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE nixos-nspawn(machine2): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. ░ Spawning container machine2 on /build/vm-state-machine2. ░ Spawning container machine1 on /build/vm-state-machine1. machine2 # [6727582.891832] machine2 systemd-journald[54]: Journal started machine2 # [6727582.891906] machine2 systemd-journald[54]: Runtime Journal (/run/log/journal/55a6d152922d4c078cfb742137686a23) is 8M, max 2.5G, 2.4G free. machine2 # [6727582.896929] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... machine2 # [6727582.897920] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... machine2 # [6727582.906597] machine2 systemd-journald[54]: Time spent on flushing to /var/log/journal/55a6d152922d4c078cfb742137686a23 is 1.326ms for 4 entries. machine2 # [6727582.906597] machine2 systemd-journald[54]: System Journal (/var/log/journal/55a6d152922d4c078cfb742137686a23) is 8M, max 4G, 3.9G free. machine2 # [6727582.926415] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. machine2 # [6727582.926693] machine2 systemd[1]: Reached target Preparation for Local File Systems. machine1 # [6727582.877515] machine1 systemd-journald[54]: Journal started machine2 # [6727582.926773] machine2 systemd[1]: Reached target Local File Systems. machine1 # [6727582.877564] machine1 systemd-journald[54]: Runtime Journal (/run/log/journal/6767c3a6f65048a38bcbbbf4265f6574) is 8M, max 2.5G, 2.4G free. machine2 # [6727582.927531] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. machine1 # [6727582.883906] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... machine2 # [6727582.927576] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine1 # [6727582.884564] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... machine2 # [6727582.928431] machine2 systemd[1]: Starting Save Transient machine-id to Disk... machine1 # [6727582.894863] machine1 systemd-journald[54]: Time spent on flushing to /var/log/journal/6767c3a6f65048a38bcbbbf4265f6574 is 1.611ms for 4 entries. machine2 # [6727582.928465] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine1 # [6727582.894863] machine1 systemd-journald[54]: System Journal (/var/log/journal/6767c3a6f65048a38bcbbbf4265f6574) is 8M, max 4G, 3.9G free. machine2 # [6727582.985875] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. machine1 # [6727582.898893] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. machine2 # [6727582.987669] machine2 systemd[1]: Starting Create System Files and Directories... machine1 # [6727582.899103] machine1 systemd[1]: Reached target Preparation for Local File Systems. machine2 # [6727583.043154] machine2 systemd[1]: Finished Firewall. machine1 # [6727582.899175] machine1 systemd[1]: Reached target Local File Systems. machine2 # [6727583.043324] machine2 systemd[1]: Reached target Preparation for Network. machine1 # [6727582.899864] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. machine2 # [6727583.047749] machine2 systemd-tmpfiles[127]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine1 # [6727582.899905] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine2 # [6727583.047927] machine2 systemd-tmpfiles[127]: fchmod() of /var/log/journal failed: Operation not permitted machine1 # [6727582.900676] machine1 systemd[1]: Starting Save Transient machine-id to Disk... machine2 # [6727583.048061] machine2 systemd-tmpfiles[127]: fchmod() of /var/log/journal/55a6d152922d4c078cfb742137686a23 failed: Operation not permitted machine1 # [6727582.900706] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine2 # [6727583.048248] machine2 systemd-tmpfiles[127]: fchmod() of /run/log/journal failed: Operation not permitted machine1 # [6727582.987008] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. machine2 # [6727583.049498] machine2 systemd[1]: Finished Create System Files and Directories. machine1 # [6727582.988171] machine1 systemd[1]: Starting Create System Files and Directories... machine2 # [6727583.050554] machine2 systemd[1]: Starting Rebuild Journal Catalog... machine1 # [6727583.043778] machine1 systemd[1]: Finished Firewall. machine2 # [6727583.051262] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine1 # [6727583.043915] machine1 systemd[1]: Reached target Preparation for Network. machine2 # [6727583.066038] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine1 # [6727583.049875] machine1 systemd-tmpfiles[128]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine2 # [6727583.073052] machine2 systemd[1]: Finished Rebuild Journal Catalog. machine1 # [6727583.050093] machine1 systemd-tmpfiles[128]: fchmod() of /var/log/journal failed: Operation not permitted machine2 # [6727583.074895] machine2 systemd[1]: Starting Update is Completed... machine1 # [6727583.050248] machine1 systemd-tmpfiles[128]: fchmod() of /var/log/journal/6767c3a6f65048a38bcbbbf4265f6574 failed: Operation not permitted machine2 # [6727583.085487] machine2 systemd[1]: Finished Update is Completed. machine1 # [6727583.050481] machine1 systemd-tmpfiles[128]: fchmod() of /run/log/journal failed: Operation not permitted machine2 # [6727583.085662] machine2 systemd[1]: Reached target System Initialization. machine1 # [6727583.052085] machine1 systemd[1]: Finished Create System Files and Directories. machine2 # [6727583.085749] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine1 # [6727583.053424] machine1 systemd[1]: Starting Rebuild Journal Catalog... machine2 # [6727583.085788] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. machine1 # [6727583.054265] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine2 # [6727583.085812] machine2 systemd[1]: Reached target Timer Units. machine1 # [6727583.067258] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine2 # [6727583.085937] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. machine1 # [6727583.077397] machine1 systemd[1]: Finished Rebuild Journal Catalog. machine2 # [6727583.086074] machine2 systemd[1]: Listening on Nix Daemon Socket. machine1 # [6727583.078365] machine1 systemd[1]: Starting Update is Completed... machine2 # [6727583.087404] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine2 # [6727583.088687] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine2 # [6727583.088815] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine2 # [6727583.088843] machine2 systemd[1]: Reached target Socket Units. machine2 # [6727583.088891] machine2 systemd[1]: Reached target Basic System. machine2 # [6727583.090006] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... machine2 # [6727583.090802] machine2 systemd[1]: Starting Address configuration of eth1... machine2 # [6727583.091667] machine2 systemd[1]: Starting Extra networking commands.... machine2 # [6727583.092560] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine2 # [6727583.093356] machine2 systemd[1]: Starting SSH Host Keys Generation... machine2 # [6727583.109361] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. machine2 # [6727583.109585] machine2 network-addresses-eth1-start[166]: adding address 192.168.1.2/24... done machine2 # [6727583.113351] machine2 network-addresses-eth1-start[166]: adding address 2001:db8:1::2/64... done machine2 # [6727583.117820] machine2 systemd[1]: Finished Address configuration of eth1. machine1 # [6727583.088325] machine1 systemd[1]: Finished Update is Completed. machine1 # [6727583.088524] machine1 systemd[1]: Reached target System Initialization. machine1 # [6727583.088619] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine1 # [6727583.088659] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. machine1 # [6727583.088685] machine1 systemd[1]: Reached target Timer Units. machine1 # [6727583.088818] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. machine1 # [6727583.088965] machine1 systemd[1]: Listening on Nix Daemon Socket. machine1 # [6727583.090394] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine1 # [6727583.091680] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine1 # [6727583.091803] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine1 # [6727583.091834] machine1 systemd[1]: Reached target Socket Units. machine1 # [6727583.091893] machine1 systemd[1]: Reached target Basic System. machine1 # [6727583.093072] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... machine1 # [6727583.093955] machine1 systemd[1]: Starting Address configuration of eth1... machine1 # [6727583.094849] machine1 systemd[1]: Starting Extra networking commands.... machine1 # [6727583.095786] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [6727583.096615] machine1 systemd[1]: Starting SSH Host Keys Generation... machine1 # [6727583.113626] machine1 network-addresses-eth1-start[166]: adding address 192.168.1.1/24... done machine1 # [6727583.114332] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. machine1 # [6727583.117222] machine1 network-addresses-eth1-start[166]: adding address 2001:db8:1::1/64... done machine1 # [6727583.121305] machine1 systemd[1]: Finished Address configuration of eth1. machine2 # [6727583.154168] machine2 systemd[1]: nscd.service: Deactivated successfully. machine2 # [6727583.154311] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine2 # [6727583.156457] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [6727583.158376] machine1 systemd[1]: nscd.service: Deactivated successfully. machine1 # [6727583.158480] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine1 # [6727583.160361] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [6727583.168614] machine1 systemd[1]: Finished Extra networking commands.. machine1 # [6727583.168907] machine1 systemd[1]: Reached target Network. machine1 # [6727583.225683] machine1 nsncd[236]: Aug 25 20:10:09.278 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine1 # [6727583.225806] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). machine1 # [6727583.225864] machine1 systemd[1]: Reached target Host and Network Name Lookups. machine1 # [6727583.225923] machine1 systemd[1]: Reached target User and Group Name Lookups. machine1 # [6727583.227204] machine1 systemd[1]: Starting User Login Management... machine1 # [6727583.228065] machine1 systemd[1]: Starting Permit User Sessions... machine1 # [6727583.237483] machine1 systemd[1]: Finished Permit User Sessions. machine1 # [6727583.238466] machine1 systemd[1]: Started Console Getty. machine1 # [6727583.238506] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine1 # [6727583.238529] machine1 systemd[1]: Reached target Login Prompts. machine2 # [6727583.163505] machine2 systemd[1]: Finished Extra networking commands.. machine2 # [6727583.163678] machine2 systemd[1]: Reached target Network. machine2 # [6727583.222119] machine2 nsncd[237]: Aug 25 20:10:09.275 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine2 # [6727583.222192] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). machine2 # [6727583.222252] machine2 systemd[1]: Reached target Host and Network Name Lookups. machine2 # [6727583.222314] machine2 systemd[1]: Reached target User and Group Name Lookups. machine2 # [6727583.223876] machine2 systemd[1]: Starting User Login Management... machine2 # [6727583.225005] machine2 systemd[1]: Starting Permit User Sessions... machine2 # [6727583.234400] machine2 systemd[1]: Finished Permit User Sessions. machine2 # [6727583.235459] machine2 systemd[1]: Started Console Getty. machine2 # [6727583.235508] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine2 # [6727583.235527] machine2 systemd[1]: Reached target Login Prompts. machine1 # [6727583.588177] machine1 systemd-logind[255]: New seat seat0. machine1 # [6727583.588507] machine1 systemd[1]: Started User Login Management. machine1 # [6727583.590244] machine1 systemd[1]: Starting D-Bus System Message Bus... machine1 # [6727583.591609] machine1 systemd[1]: Starting linger-users.service... machine2 # [6727583.588382] machine2 systemd-logind[255]: New seat seat0. machine1 # [6727583.637680] machine1 systemd[1]: linger-users.service: Deactivated successfully. machine2 # [6727583.588655] machine2 systemd[1]: Started User Login Management. machine1 # [6727583.637758] machine1 systemd[1]: Finished linger-users.service. machine2 # [6727583.590267] machine2 systemd[1]: Starting D-Bus System Message Bus... machine1 # [6727583.805632] machine1 dbus-broker-launch[265]: Looking up NSS user entry for 'systemd-timesync'... machine2 # [6727583.591611] machine2 systemd[1]: Starting linger-users.service... machine1 # [6727583.806663] machine1 dbus-broker-launch[265]: NSS returned no entry for 'systemd-timesync' machine2 # [6727583.637098] machine2 systemd[1]: linger-users.service: Deactivated successfully. machine1 # [6727583.806663] machine1 dbus-broker-launch[265]: Invalid user-name in /nix/store/9km33hjpw8h8m70w8x61zbdvz7l0xz06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine2 # [6727583.637255] machine2 systemd[1]: Finished linger-users.service. machine1 # [6727583.807200] machine1 systemd[1]: Started D-Bus System Message Bus. machine2 # [6727583.805940] machine2 dbus-broker-launch[265]: Looking up NSS user entry for 'systemd-timesync'... machine2 # [6727583.806569] machine2 dbus-broker-launch[265]: NSS returned no entry for 'systemd-timesync' machine1 # [6727583.814099] machine1 dbus-broker-launch[265]: Ready machine2 # [6727583.806569] machine2 dbus-broker-launch[265]: Invalid user-name in /nix/store/9km33hjpw8h8m70w8x61zbdvz7l0xz06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine2 # [6727583.806967] machine2 systemd[1]: Started D-Bus System Message Bus. machine2 # [6727583.814089] machine2 dbus-broker-launch[265]: Ready machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Generating public/private rsa key pair. machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: The key fingerprint is: machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: SHA256:9k3sfFrN6ZrFFQ4wPYQ2bxESKn7866XSshcw1ZXvk4g root@machine2 machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: The key's randomart image is: machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: +---[RSA 4096]----+ machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | =*oo..| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .=+= . | machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | . .o o.o..| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | . oo . oo o| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .Soo = .oo| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | ....E ..=+| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | o.=.o++| machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | o o+++ | machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .*+.o.. | machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: +----[SHA256]-----+ machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Generating public/private ed25519 key pair. machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: The key fingerprint is: machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: SHA256:osYyeVYrONPXYXfh2+9ltWzNrYOg0N22gkT6QrpGSCo root@machine2 machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: The key's randomart image is: machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: +--[ED25519 256]--+ machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | | machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | | machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | . | machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | . . . . | machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | o . o+S...o .| machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: |E .=.o+=ooo.oo..=| machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: |. B.Ooo+.o o.o.+*| machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | Ooo. + . o o+.| machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | ... . . .oo| machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: +----[SHA256]-----+ machine2 # [6727584.804573] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. machine2 # [6727584.804828] machine2 systemd[1]: Finished SSH Host Keys Generation. machine2 # [6727584.805142] machine2 systemd[1]: sshd-keygen.service: Consumed 3.411s CPU time over 1.711s wall clock time. machine2 # [6727584.807938] machine2 systemd[1]: Starting SSH Daemon... machine2 # [6727584.824011] machine2 sshd[277]: Server listening on 0.0.0.0 port 22. machine2 # [6727584.824040] machine2 sshd[277]: Server listening on :: port 22. machine2 # [6727584.824202] machine2 systemd[1]: Started SSH Daemon. machine2 # [6727584.824460] machine2 systemd[1]: Reached target Multi-User System. machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Generating public/private rsa key pair. machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: The key fingerprint is: machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: SHA256:j95lJIumGsXXiL/lPtYXdIaffXQ3VetTvUk8M4VRSDQ root@machine1 machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: The key's randomart image is: machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: +---[RSA 4096]----+ machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | oE==| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | +.=| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | O+| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . . o =.&| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | + S o .. X*| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . o + + ..=| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . = +.o ..| machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . + =oo. . | machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | ... oo+. . | machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: +----[SHA256]-----+ machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Generating public/private ed25519 key pair. machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: The key fingerprint is: machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: SHA256:liAT/6+tk00S5+HiJSWulgpxbP7C0AVuNaf6MXhTQLs root@machine1 machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: The key's randomart image is: machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: +--[ED25519 256]--+ machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | ... | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o+.. | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .oo+= | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .ooo++.+ | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o++EoSB . | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .=+ =.=.= | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o.o B O. | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o.= +o. | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .+. oo. | machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: +----[SHA256]-----+ machine1 # [6727584.864986] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. machine1 # [6727584.865064] machine1 systemd[1]: Finished SSH Host Keys Generation. machine1 # [6727584.866611] machine1 systemd[1]: Starting SSH Daemon... machine1 # [6727584.882202] machine1 sshd[277]: Server listening on 0.0.0.0 port 22. machine1 # [6727584.882228] machine1 sshd[277]: Server listening on :: port 22. machine1 # [6727584.882375] machine1 systemd[1]: Started SSH Daemon. machine1 # [6727584.882615] machine1 systemd[1]: Reached target Multi-User System. machine2 # [6727585.340407] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine2 # [6727585.342204] machine2 systemd[1]: Finished Save Transient machine-id to Disk. machine2 # [6727585.342695] machine2 systemd[1]: Startup finished in 2.846s. machine1 # [6727585.340098] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine1 # [6727585.342072] machine1 systemd[1]: Finished Save Transient machine-id to Disk. machine1 # [6727585.342582] machine1 systemd[1]: Startup finished in 2.846s. machine1: (finished: must succeed: systemctl status sshd, in 3.66 seconds) machine2: must succeed: systemctl status sshd machine2: (finished: must succeed: systemctl status sshd, in 0.01 seconds) machine1: waiting for unit sshd machine1: (finished: waiting for unit sshd, in 0.01 seconds) machine2: waiting for unit sshd machine2: (finished: waiting for unit sshd, in 0.01 seconds) machine1: must succeed: ip addr show eth1 machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds) machine2: must succeed: ip addr show eth1 machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds) machine1: must succeed: ping -c 1 machine2 machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds) (finished: run the VM test script, in 3.73 seconds) test script finished in 4.13s cleanup kill NspawnMachine (pid 52) kill NspawnMachine (pid 53) Container machine1 terminated by signal KILL. Container machine2 terminated by signal KILL. (finished: cleanup, in 0.38 seconds)