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(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. 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. 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 machine1 on /build/vm-state-machine1. ░ Spawning container machine2 on /build/vm-state-machine2. machine1 # [27696.165916] machine1 systemd-journald[54]: Journal started machine1 # [27696.165969] machine1 systemd-journald[54]: Runtime Journal (/run/log/journal/89c0591259e14160b8fde0138feecdf5) is 8M, max 2.5G, 2.4G free. machine1 # [27696.169991] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... machine1 # [27696.170742] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... machine1 # [27696.178395] machine1 systemd-journald[54]: Time spent on flushing to /var/log/journal/89c0591259e14160b8fde0138feecdf5 is 1.516ms for 4 entries. machine1 # [27696.178395] machine1 systemd-journald[54]: System Journal (/var/log/journal/89c0591259e14160b8fde0138feecdf5) is 8M, max 4G, 3.9G free. machine1 # [27696.186067] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. machine1 # [27696.186308] machine1 systemd[1]: Reached target Preparation for Local File Systems. machine1 # [27696.186393] machine1 systemd[1]: Reached target Local File Systems. machine1 # [27696.187124] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. machine1 # [27696.187169] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine1 # [27696.187931] machine1 systemd[1]: Starting Save Transient machine-id to Disk... machine1 # [27696.187966] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine1 # [27696.230032] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. machine1 # [27696.231108] machine1 systemd[1]: Starting Create System Files and Directories... machine1 # [27696.240739] machine1 systemd[1]: Finished Save Transient machine-id to Disk. machine1 # [27696.250340] machine1 systemd-tmpfiles[109]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine1 # [27696.250534] machine1 systemd-tmpfiles[109]: fchmod() of /var/log/journal failed: Operation not permitted machine1 # [27696.250672] machine1 systemd-tmpfiles[109]: fchmod() of /var/log/journal/89c0591259e14160b8fde0138feecdf5 failed: Operation not permitted machine1 # [27696.250887] machine1 systemd-tmpfiles[109]: fchmod() of /run/log/journal failed: Operation not permitted machine1 # [27696.252304] machine1 systemd[1]: Finished Create System Files and Directories. machine1 # [27696.253727] machine1 systemd[1]: Starting Rebuild Journal Catalog... machine1 # [27696.254641] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine1 # [27696.267747] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine1 # [27696.274900] machine1 systemd[1]: Finished Rebuild Journal Catalog. machine1 # [27696.276175] machine1 systemd[1]: Starting Update is Completed... machine1 # [27696.285642] machine1 systemd[1]: Finished Update is Completed. machine1 # [27696.285836] machine1 systemd[1]: Reached target System Initialization. machine1 # [27696.285933] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine1 # [27696.285970] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. machine1 # [27696.285995] machine1 systemd[1]: Reached target Timer Units. machine1 # [27696.286118] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. machine1 # [27696.286276] machine1 systemd[1]: Listening on Nix Daemon Socket. machine1 # [27696.287552] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine1 # [27696.288670] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine1 # [27696.288794] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine1 # [27696.288821] machine1 systemd[1]: Reached target Socket Units. machine1 # [27696.288875] machine1 systemd[1]: Reached target Basic System. machine1 # [27696.289951] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... machine2 # [27696.158329] machine2 systemd-journald[54]: Journal started machine1 # [27696.290824] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine2 # [27696.158387] machine2 systemd-journald[54]: Runtime Journal (/run/log/journal/a4e8fd8d8d16460c944649f398101df9) is 8M, max 2.5G, 2.4G free. machine1 # [27696.291554] machine1 systemd[1]: Starting SSH Host Keys Generation... machine2 # [27696.163469] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... machine1 # [27696.309450] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. machine2 # [27696.164181] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... machine1 # [27696.319714] machine1 systemd[1]: Finished Firewall. machine2 # [27696.173849] machine2 systemd-journald[54]: Time spent on flushing to /var/log/journal/a4e8fd8d8d16460c944649f398101df9 is 1.455ms for 4 entries. machine1 # [27696.319894] machine1 systemd[1]: Reached target Preparation for Network. machine2 # [27696.173849] machine2 systemd-journald[54]: System Journal (/var/log/journal/a4e8fd8d8d16460c944649f398101df9) is 8M, max 4G, 3.9G free. machine1 # [27696.320840] machine1 systemd[1]: Starting Address configuration of eth1... machine2 # [27696.177306] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. machine1 # [27696.321713] machine1 systemd[1]: Starting Extra networking commands.... machine2 # [27696.177563] machine2 systemd[1]: Reached target Preparation for Local File Systems. machine2 # [27696.177642] machine2 systemd[1]: Reached target Local File Systems. machine2 # [27696.178369] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. machine2 # [27696.178414] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine2 # [27696.179237] machine2 systemd[1]: Starting Save Transient machine-id to Disk... machine2 # [27696.179270] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine2 # [27696.229824] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. machine2 # [27696.231161] machine2 systemd[1]: Starting Create System Files and Directories... machine2 # [27696.240368] machine2 systemd[1]: Finished Save Transient machine-id to Disk. machine2 # [27696.247845] machine2 systemd-tmpfiles[113]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine2 # [27696.248432] machine2 systemd-tmpfiles[113]: fchmod() of /var/log/journal failed: Operation not permitted machine2 # [27696.248576] machine2 systemd-tmpfiles[113]: fchmod() of /var/log/journal/a4e8fd8d8d16460c944649f398101df9 failed: Operation not permitted machine2 # [27696.248791] machine2 systemd-tmpfiles[113]: fchmod() of /run/log/journal failed: Operation not permitted machine2 # [27696.250085] machine2 systemd[1]: Finished Create System Files and Directories. machine2 # [27696.251125] machine2 systemd[1]: Starting Rebuild Journal Catalog... machine2 # [27696.251813] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine2 # [27696.264766] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine2 # [27696.271907] machine2 systemd[1]: Finished Rebuild Journal Catalog. machine2 # [27696.272949] machine2 systemd[1]: Starting Update is Completed... machine2 # [27696.282912] machine2 systemd[1]: Finished Update is Completed. machine2 # [27696.283082] machine2 systemd[1]: Reached target System Initialization. machine2 # [27696.283165] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine2 # [27696.283199] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. machine2 # [27696.283219] machine2 systemd[1]: Reached target Timer Units. machine2 # [27696.283326] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. machine2 # [27696.283449] machine2 systemd[1]: Listening on Nix Daemon Socket. machine2 # [27696.284472] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine2 # [27696.285331] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine2 # [27696.285431] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine2 # [27696.285451] machine2 systemd[1]: Reached target Socket Units. machine2 # [27696.285484] machine2 systemd[1]: Reached target Basic System. machine2 # [27696.286460] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... machine2 # [27696.287254] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine2 # [27696.287928] machine2 systemd[1]: Starting SSH Host Keys Generation... machine2 # [27696.303889] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. machine2 # [27696.313743] machine2 systemd[1]: Finished Firewall. machine2 # [27696.313919] machine2 systemd[1]: Reached target Preparation for Network. machine2 # [27696.314863] machine2 systemd[1]: Starting Address configuration of eth1... machine2 # [27696.315913] machine2 systemd[1]: Starting Extra networking commands.... machine2 # [27696.331784] machine2 network-addresses-eth1-start[179]: adding address 192.168.1.2/24... done machine2 # [27696.334202] machine2 network-addresses-eth1-start[179]: adding address 2001:db8:1::2/64... done machine2 # [27696.338759] machine2 systemd[1]: Finished Address configuration of eth1. machine2 # [27696.354761] machine2 nsncd[153]: Sep 04 15:08:36.340 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine2 # [27696.354882] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). machine2 # [27696.354949] machine2 systemd[1]: Reached target Host and Network Name Lookups. machine2 # [27696.355005] machine2 systemd[1]: Reached target User and Group Name Lookups. machine2 # [27696.356171] machine2 systemd[1]: Starting User Login Management... machine2 # [27696.378268] machine2 systemd[1]: Stopped target Host and Network Name Lookups. machine2 # [27696.378326] machine2 systemd[1]: Stopping Host and Network Name Lookups... machine2 # [27696.378374] machine2 systemd[1]: Stopped target User and Group Name Lookups. machine2 # [27696.378400] machine2 systemd[1]: Stopping User and Group Name Lookups... machine2 # [27696.379481] machine2 systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine2 # [27696.382305] machine2 systemd[1]: nscd.service: Deactivated successfully. machine2 # [27696.382380] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine2 # [27696.384586] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine2 # [27696.394057] machine2 systemd[1]: Finished Extra networking commands.. machine2 # [27696.394240] machine2 systemd[1]: Reached target Network. machine2 # [27696.456454] machine2 nsncd[253]: Sep 04 15:08:36.442 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine2 # [27696.456345] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). machine2 # [27696.456401] machine2 systemd[1]: Reached target Host and Network Name Lookups. machine2 # [27696.456457] machine2 systemd[1]: Reached target User and Group Name Lookups. machine1 # [27696.336869] machine1 network-addresses-eth1-start[179]: adding address 192.168.1.1/24... done machine1 # [27696.339829] machine1 network-addresses-eth1-start[179]: adding address 2001:db8:1::1/64... done machine1 # [27696.344267] machine1 systemd[1]: Finished Address configuration of eth1. machine1 # [27696.356259] machine1 nsncd[151]: Sep 04 15:08:36.342 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine1 # [27696.356344] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). machine1 # [27696.356414] machine1 systemd[1]: Reached target Host and Network Name Lookups. machine1 # [27696.356478] machine1 systemd[1]: Reached target User and Group Name Lookups. machine1 # [27696.357653] machine1 systemd[1]: Starting User Login Management... machine1 # [27696.377907] machine1 systemd[1]: Stopped target Host and Network Name Lookups. machine1 # [27696.377967] machine1 systemd[1]: Stopping Host and Network Name Lookups... machine1 # [27696.378007] machine1 systemd[1]: Stopped target User and Group Name Lookups. machine1 # [27696.378031] machine1 systemd[1]: Stopping User and Group Name Lookups... machine1 # [27696.378181] machine1 systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine1 # [27696.382062] machine1 systemd[1]: nscd.service: Deactivated successfully. machine1 # [27696.382240] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine1 # [27696.384454] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [27696.393320] machine1 systemd[1]: Finished Extra networking commands.. machine1 # [27696.393508] machine1 systemd[1]: Reached target Network. machine2 # [27696.457432] machine2 systemd[1]: Starting Permit User Sessions... machine2 # [27696.499443] machine2 systemd[1]: Finished Permit User Sessions. machine2 # [27696.501035] machine2 systemd[1]: Started Console Getty. machine2 # [27696.501106] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine2 # [27696.501143] machine2 systemd[1]: Reached target Login Prompts. machine1 # [27696.458918] machine1 nsncd[255]: Sep 04 15:08:36.444 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine1 # [27696.458911] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). machine1 # [27696.458970] machine1 systemd[1]: Reached target Host and Network Name Lookups. machine1 # [27696.459029] machine1 systemd[1]: Reached target User and Group Name Lookups. machine1 # [27696.459833] machine1 systemd[1]: Starting Permit User Sessions... machine1 # [27696.499138] machine1 systemd[1]: Finished Permit User Sessions. machine1 # [27696.500160] machine1 systemd[1]: Started Console Getty. machine1 # [27696.500208] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine1 # [27696.500226] machine1 systemd[1]: Reached target Login Prompts. machine2 # [27696.758371] machine2 systemd-logind[220]: New seat seat0. machine2 # [27696.800396] machine2 systemd[1]: Starting D-Bus System Message Bus... machine1 # [27696.746759] machine1 systemd-logind[222]: New seat seat0. machine2 # [27696.800486] machine2 systemd[1]: Started User Login Management. machine1 # [27696.747840] machine1 systemd[1]: Starting D-Bus System Message Bus... machine2 # [27696.801302] machine2 systemd[1]: Starting linger-users.service... machine1 # [27696.747960] machine1 systemd[1]: Started User Login Management. machine2 # [27696.813919] machine2 systemd[1]: linger-users.service: Deactivated successfully. machine1 # [27696.748825] machine1 systemd[1]: Starting linger-users.service... machine2 # [27696.813983] machine2 systemd[1]: Finished linger-users.service. machine1 # [27696.812035] machine1 systemd[1]: linger-users.service: Deactivated successfully. machine2 # [27696.931470] machine2 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'... machine1 # [27696.812314] machine1 systemd[1]: Finished linger-users.service. machine2 # [27696.932615] machine2 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync' machine1 # [27696.928980] machine1 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'... machine2 # [27696.932615] machine2 dbus-broker-launch[276]: Invalid user-name in /nix/store/mjhn60dbh9ps7d82a3mq60nz2kcv8sw9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine1 # [27696.929772] machine1 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync' machine2 # [27696.932993] machine2 systemd[1]: Started D-Bus System Message Bus. machine1 # [27696.929772] machine1 dbus-broker-launch[276]: Invalid user-name in /nix/store/mjhn60dbh9ps7d82a3mq60nz2kcv8sw9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine2 # [27696.939999] machine2 dbus-broker-launch[276]: Ready machine1 # [27696.930154] machine1 systemd[1]: Started D-Bus System Message Bus. machine2 # [27697.149469] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine1 # [27696.937138] machine1 dbus-broker-launch[276]: Ready machine1 # [27697.158882] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Generating public/private rsa key pair. machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine2 # [27697.548346] machine2 sshd-keygen-start[174]: The key fingerprint is: machine2 # [27697.548346] machine2 sshd-keygen-start[174]: SHA256:bHXjncKjBuozp4P8JHJKFQjWrso8LcUP4QYed/urBXo root@machine2 machine2 # [27697.548346] machine2 sshd-keygen-start[174]: The key's randomart image is: machine2 # [27697.548346] machine2 sshd-keygen-start[174]: +---[RSA 4096]----+ machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |... | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |.. o | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o . . o | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o + o . . + o . | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |. B +.. S = o | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o B...o . . o | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |+ *o=E+. o | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |.* =+==... | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | + o=B. | machine2 # [27697.548346] machine2 sshd-keygen-start[174]: +----[SHA256]-----+ machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Generating public/private ed25519 key pair. machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine2 # [27697.565211] machine2 sshd-keygen-start[286]: The key fingerprint is: machine2 # [27697.565211] machine2 sshd-keygen-start[286]: SHA256:/91e6L3VwWAvhDs6e8ISR1takRrbnx+tfv4nPSbaaSQ root@machine2 machine2 # [27697.565211] machine2 sshd-keygen-start[286]: The key's randomart image is: machine2 # [27697.565211] machine2 sshd-keygen-start[286]: +--[ED25519 256]--+ machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . | machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . o. | machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | =..+ | machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | + ++ + | machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | S =o...+.| machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . =.E.+.o+| machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | +o. o oo=| machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . ooo.=+**| machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | ..o.++**@| machine2 # [27697.565211] machine2 sshd-keygen-start[286]: +----[SHA256]-----+ machine2 # [27697.566856] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. machine2 # [27697.567026] machine2 systemd[1]: Finished SSH Host Keys Generation. machine2 # [27697.567224] machine2 systemd[1]: sshd-keygen.service: Consumed 2.548s CPU time over 1.278s wall clock time. machine2 # [27697.568395] machine2 systemd[1]: Starting SSH Daemon... machine2 # [27697.607551] machine2 sshd[288]: Server listening on 0.0.0.0 port 22. machine2 # [27697.607575] machine2 sshd[288]: Server listening on :: port 22. machine2 # [27697.607701] machine2 systemd[1]: Started SSH Daemon. machine2 # [27697.607970] machine2 systemd[1]: Reached target Multi-User System. machine2 # [27697.608219] machine2 systemd[1]: Startup finished in 1.832s. machine1: (finished: must succeed: systemctl status sshd, in 2.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.02 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 2.73 seconds) test script finished in 2.79s cleanup kill NspawnMachine (pid 52) machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Generating public/private rsa key pair. machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine1 # [27697.854779] machine1 sshd-keygen-start[170]: The key fingerprint is: machine1 # [27697.854779] machine1 sshd-keygen-start[170]: SHA256:8cMnvhC1Q5KcUEoAk+RC1dB7QAjccUuldcnHv4KOrt8 root@machine1 machine1 # [27697.854779] machine1 sshd-keygen-start[170]: The key's randomart image is: machine1 # [27697.854779] machine1 sshd-keygen-start[170]: +---[RSA 4096]----+ machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |.+B*O=++o.o | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |.o.+o=++.= o | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |. . o+ * + . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | . . . B . . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | . S O . . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | + * . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | + . . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | ..o . | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | .+o E. | machine1 # [27697.854779] machine1 sshd-keygen-start[170]: +----[SHA256]-----+ machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Generating public/private ed25519 key pair. machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine1 # [27697.870394] machine1 sshd-keygen-start[286]: The key fingerprint is: machine1 # [27697.870394] machine1 sshd-keygen-start[286]: SHA256:8r6BKM8sMWmGoLVINtiNRRRmZVeofvgTc/X8rNIzOjs root@machine1 machine1 # [27697.870394] machine1 sshd-keygen-start[286]: The key's randomart image is: machine1 # [27697.870394] machine1 sshd-keygen-start[286]: +--[ED25519 256]--+ machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o*oo .o. | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o.. .. | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |.. + . | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |o++ . . . | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |=+.o ...S . o | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |+ B .o++ . o | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o.o. .oo+ . o | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | .= .o. E + o| machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | .+ oo o*.+ | machine1 # [27697.870394] machine1 sshd-keygen-start[286]: +----[SHA256]-----+ machine1 # [27697.871634] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. machine1 # [27697.871757] machine1 systemd[1]: Finished SSH Host Keys Generation. machine1 # [27697.873929] machine1 systemd[1]: Starting SSH Daemon... machine1 # [27697.916677] machine1 sshd[288]: Server listening on 0.0.0.0 port 22. machine1 # [27697.916713] machine1 sshd[288]: Server listening on :: port 22. machine1 # [27697.916899] machine1 systemd[1]: Started SSH Daemon. machine1 # [27697.917337] machine1 systemd[1]: Reached target Multi-User System. machine1 # [27697.917695] machine1 systemd[1]: Startup finished in 2.133s. kill NspawnMachine (pid 53) Container machine1 terminated by signal KILL. Container machine2 terminated by signal KILL. (finished: cleanup, in 0.33 seconds)