build01: building 27l68qkpmy94licymwpgd2jan0s5f5rs-container-test-run-container.drv 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 machine1 on /build/vm-state-machine1. ░ Spawning container machine2 on /build/vm-state-machine2. machine1 # [38509.665481] machine1 systemd-journald[57]: Journal started machine2 # [38509.655804] machine2 systemd-journald[57]: Journal started machine1 # [38509.665541] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/4953d2681a5946cb8902e47d3d4057f1) is 8M, max 2.5G, 2.4G free. machine2 # [38509.655864] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/3f6bfda2a94a48219d0187add7fa338a) is 8M, max 2.5G, 2.4G free. machine1 # [38509.671764] machine1 systemd[1]: Finished Apply Kernel Variables. machine2 # [38509.671665] machine2 systemd[1]: Finished Apply Kernel Variables. machine1 # [38509.683242] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine1 # [38509.695872] machine1 systemd[1]: Starting Flush Journal to Persistent Storage... machine1 # [38509.696546] machine1 systemd[1]: Starting Create Static Device Nodes in /dev... machine1 # [38509.734618] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/4953d2681a5946cb8902e47d3d4057f1 is 1.747ms for 6 entries. machine1 # [38509.734618] machine1 systemd-journald[57]: System Journal (/var/log/journal/4953d2681a5946cb8902e47d3d4057f1) is 8M, max 4G, 3.9G free. machine1 # [38509.742644] machine1 systemd[1]: Finished Create Static Device Nodes in /dev. machine1 # [38509.743244] machine1 systemd[1]: Reached target Preparation for Local File Systems. machine1 # [38509.743346] machine1 systemd[1]: Reached target Local File Systems. machine1 # [38509.744207] machine1 systemd[1]: Listening on Boot Loader Control Service Socket. machine1 # [38509.744259] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine1 # [38509.745115] machine1 systemd[1]: Starting Save Transient machine-id to Disk... machine1 # [38509.745146] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine1 # [38509.757978] machine1 systemd[1]: Finished Flush Journal to Persistent Storage. machine1 # [38509.759045] machine1 systemd[1]: Starting Create System Files and Directories... machine1 # [38509.773556] machine1 systemd-tmpfiles[127]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine1 # [38509.773715] machine1 systemd-tmpfiles[127]: fchmod() of /var/log/journal failed: Operation not permitted machine1 # [38509.773826] machine1 systemd-tmpfiles[127]: fchmod() of /var/log/journal/4953d2681a5946cb8902e47d3d4057f1 failed: Operation not permitted machine1 # [38509.773983] machine1 systemd-tmpfiles[127]: fchmod() of /run/log/journal failed: Operation not permitted machine1 # [38509.775293] machine1 systemd[1]: Finished Create System Files and Directories. machine1 # [38509.776490] machine1 systemd[1]: Starting Rebuild Journal Catalog... machine1 # [38509.777471] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine1 # [38509.793310] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine1 # [38509.795575] machine1 systemd[1]: Finished Rebuild Journal Catalog. machine1 # [38509.796794] machine1 systemd[1]: Starting Update is Completed... machine1 # [38509.807712] machine1 systemd[1]: Finished Update is Completed. machine1 # [38509.807877] machine1 systemd[1]: Reached target System Initialization. machine1 # [38509.807961] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine1 # [38509.808008] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories. machine1 # [38509.808028] machine1 systemd[1]: Reached target Timer Units. machine1 # [38509.808146] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket. machine1 # [38509.808267] machine1 systemd[1]: Listening on Nix Daemon Socket. machine1 # [38509.809423] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine1 # [38509.810391] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine1 # [38509.810485] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine1 # [38509.810506] machine1 systemd[1]: Reached target Socket Units. machine1 # [38509.810544] machine1 systemd[1]: Reached target Basic System. machine1 # [38509.811616] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database... machine1 # [38509.812515] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [38509.813252] machine1 systemd[1]: Starting SSH Host Keys Generation... machine2 # [38509.682505] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine2 # [38509.694648] machine2 systemd[1]: Starting Flush Journal to Persistent Storage... machine2 # [38509.695359] machine2 systemd[1]: Starting Create Static Device Nodes in /dev... machine2 # [38509.734694] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/3f6bfda2a94a48219d0187add7fa338a is 2.700ms for 6 entries. machine2 # [38509.734694] machine2 systemd-journald[57]: System Journal (/var/log/journal/3f6bfda2a94a48219d0187add7fa338a) is 8M, max 4G, 3.9G free. machine2 # [38509.742598] machine2 systemd[1]: Finished Create Static Device Nodes in /dev. machine2 # [38509.743248] machine2 systemd[1]: Reached target Preparation for Local File Systems. machine2 # [38509.743354] machine2 systemd[1]: Reached target Local File Systems. machine2 # [38509.744223] machine2 systemd[1]: Listening on Boot Loader Control Service Socket. machine2 # [38509.744275] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container machine2 # [38509.745121] machine2 systemd[1]: Starting Save Transient machine-id to Disk... machine2 # [38509.745158] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys machine2 # [38509.758269] machine2 systemd[1]: Finished Flush Journal to Persistent Storage. machine2 # [38509.759455] machine2 systemd[1]: Starting Create System Files and Directories... machine2 # [38509.774881] machine2 systemd-tmpfiles[128]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted machine2 # [38509.775060] machine2 systemd-tmpfiles[128]: fchmod() of /var/log/journal failed: Operation not permitted machine2 # [38509.775186] machine2 systemd-tmpfiles[128]: fchmod() of /var/log/journal/3f6bfda2a94a48219d0187add7fa338a failed: Operation not permitted machine2 # [38509.775360] machine2 systemd-tmpfiles[128]: fchmod() of /run/log/journal failed: Operation not permitted machine2 # [38509.776934] machine2 systemd[1]: Finished Create System Files and Directories. machine2 # [38509.778108] machine2 systemd[1]: Starting Rebuild Journal Catalog... machine2 # [38509.778895] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine2 # [38509.795246] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine2 # [38509.801334] machine2 systemd[1]: Finished Rebuild Journal Catalog. machine2 # [38509.802875] machine2 systemd[1]: Starting Update is Completed... machine2 # [38509.814344] machine2 systemd[1]: Finished Update is Completed. machine2 # [38509.814554] machine2 systemd[1]: Reached target System Initialization. machine2 # [38509.814661] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container machine2 # [38509.814715] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories. machine2 # [38509.814751] machine2 systemd[1]: Reached target Timer Units. machine2 # [38509.814886] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket. machine2 # [38509.815032] machine2 systemd[1]: Listening on Nix Daemon Socket. machine2 # [38509.816563] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). machine2 # [38509.817935] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). machine2 # [38509.818073] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine2 # [38509.818100] machine2 systemd[1]: Reached target Socket Units. machine2 # [38509.818150] machine2 systemd[1]: Reached target Basic System. machine2 # [38509.819338] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database... machine2 # [38509.820913] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [38509.825812] machine1 systemd[1]: Finished Firewall. machine1 # [38509.826005] machine1 systemd[1]: Reached target Preparation for Network. machine1 # [38509.826883] machine1 systemd[1]: Starting Address configuration of eth1... machine1 # [38509.827851] machine1 systemd[1]: Starting Extra networking commands.... machine1 # [38509.828052] machine1 systemd[1]: Finished Save Transient machine-id to Disk. machine1 # [38509.834511] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database. machine1 # [38509.845018] machine1 network-addresses-eth1-start[176]: adding address 192.168.1.1/24... done machine1 # [38509.848183] machine1 network-addresses-eth1-start[176]: adding address 2001:db8:1::1/64... done machine1 # [38509.853540] machine1 systemd[1]: Finished Address configuration of eth1. machine1 # [38509.896318] machine1 systemd[1]: nscd.service: Deactivated successfully. machine1 # [38509.896553] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine1 # [38509.898781] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine1 # [38509.905007] machine1 systemd[1]: Finished Extra networking commands.. machine1 # [38509.905169] machine1 systemd[1]: Reached target Network. machine2 # [38509.821780] machine2 systemd[1]: Starting SSH Host Keys Generation... machine2 # [38509.822441] machine2 systemd[1]: Finished Firewall. machine2 # [38509.823012] machine2 systemd[1]: Reached target Preparation for Network. machine2 # [38509.824074] machine2 systemd[1]: Starting Address configuration of eth1... machine2 # [38509.824986] machine2 systemd[1]: Starting Extra networking commands.... machine2 # [38509.827041] machine2 systemd[1]: Finished Save Transient machine-id to Disk. machine2 # [38509.838027] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database. machine2 # [38509.844702] machine2 network-addresses-eth1-start[171]: adding address 192.168.1.2/24... done machine2 # [38509.847593] machine2 network-addresses-eth1-start[171]: adding address 2001:db8:1::2/64... done machine2 # [38509.852340] machine2 systemd[1]: Finished Address configuration of eth1. machine2 # [38509.899034] machine2 systemd[1]: nscd.service: Deactivated successfully. machine2 # [38509.899165] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine2 # [38509.901265] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine2 # [38509.908890] machine2 systemd[1]: Finished Extra networking commands.. machine2 # [38509.909069] machine2 systemd[1]: Reached target Network. machine1 # [38510.031272] machine1 nsncd[243]: Oct 16 20:05:15.003 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine1 # [38510.031470] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd). machine1 # [38510.031581] machine1 systemd[1]: Reached target Host and Network Name Lookups. machine1 # [38510.031682] machine1 systemd[1]: Reached target User and Group Name Lookups. machine1 # [38510.033711] machine1 systemd[1]: Starting User Login Management... machine1 # [38510.034963] machine1 systemd[1]: Starting Permit User Sessions... machine1 # [38510.044639] machine1 systemd[1]: Finished Permit User Sessions. machine2 # [38510.031301] machine2 nsncd[241]: Oct 16 20:05:15.003 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine1 # [38510.046175] machine1 systemd[1]: Started Console Getty. machine2 # [38510.031286] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd). machine1 # [38510.046254] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine2 # [38510.031367] machine2 systemd[1]: Reached target Host and Network Name Lookups. machine1 # [38510.046297] machine1 systemd[1]: Reached target Login Prompts. machine2 # [38510.031420] machine2 systemd[1]: Reached target User and Group Name Lookups. machine2 # [38510.033148] machine2 systemd[1]: Starting User Login Management... machine2 # [38510.034150] machine2 systemd[1]: Starting Permit User Sessions... machine2 # [38510.044601] machine2 systemd[1]: Finished Permit User Sessions. machine2 # [38510.045755] machine2 systemd[1]: Started Console Getty. machine2 # [38510.045804] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 machine2 # [38510.045824] machine2 systemd[1]: Reached target Login Prompts. machine2 # [38510.663520] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine2 # [38510.802810] machine2 systemd-logind[259]: New seat seat0. machine2 # [38510.803069] machine2 systemd[1]: Started User Login Management. machine2 # [38510.804794] machine2 systemd[1]: Starting D-Bus System Message Bus... machine2 # [38510.806160] machine2 systemd[1]: Starting linger-users.service... machine2 # [38510.820072] machine2 systemd[1]: linger-users.service: Deactivated successfully. machine2 # [38510.820191] machine2 systemd[1]: Finished linger-users.service. machine1 # [38510.672019] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine1 # [38510.795409] machine1 systemd-logind[259]: New seat seat0. machine1 # [38510.795663] machine1 systemd[1]: Started User Login Management. machine1 # [38510.797360] machine1 systemd[1]: Starting D-Bus System Message Bus... machine1 # [38510.798666] machine1 systemd[1]: Starting linger-users.service... machine1 # [38510.813091] machine1 systemd[1]: linger-users.service: Deactivated successfully. machine1 # [38510.813351] machine1 systemd[1]: Finished linger-users.service. machine1 # [38511.059263] machine1 dbus-broker-launch[269]: Looking up NSS user entry for 'systemd-timesync'... machine1 # [38511.060478] machine1 dbus-broker-launch[269]: NSS returned no entry for 'systemd-timesync' machine1 # [38511.060478] machine1 dbus-broker-launch[269]: Invalid user-name in /nix/store/117ipki1i6mq7adbixr3qzj08nbnvv1d-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine1 # [38511.060880] machine1 systemd[1]: Started D-Bus System Message Bus. machine1 # [38511.068257] machine1 dbus-broker-launch[269]: Ready machine1 # [38511.263705] machine1 sshd-keygen-start[182]: Generating public/private rsa key pair. machine1 # [38511.263705] machine1 sshd-keygen-start[182]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine1 # [38511.263705] machine1 sshd-keygen-start[182]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine1 # [38511.263705] machine1 sshd-keygen-start[182]: The key fingerprint is: machine1 # [38511.263705] machine1 sshd-keygen-start[182]: SHA256:XXwyxrvDXwS/vPSsDHlC7dqzmhw0CGgbYPv2JPc/Xfc root@machine1 machine1 # [38511.263705] machine1 sshd-keygen-start[182]: The key's randomart image is: machine1 # [38511.263705] machine1 sshd-keygen-start[182]: +---[RSA 4096]----+ machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | o | machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | . o . o | machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | . + . B o | machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | o o o + * o | machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | = S o = . o| machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | . = . + =..+| machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | . . O.o=+| machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | o.%+oE| machine1 # [38511.263705] machine1 sshd-keygen-start[182]: | *o*=o| machine1 # [38511.263705] machine1 sshd-keygen-start[182]: +----[SHA256]-----+ machine1 # [38511.278820] machine1 sshd-keygen-start[279]: Generating public/private ed25519 key pair. machine1 # [38511.278820] machine1 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine1 # [38511.278820] machine1 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine1 # [38511.278820] machine1 sshd-keygen-start[279]: The key fingerprint is: machine1 # [38511.278820] machine1 sshd-keygen-start[279]: SHA256:5KotSWFPQeUUeDdoS6ebrO1Ij0B17v+jvW/a2ch8iGA root@machine1 machine1 # [38511.278820] machine1 sshd-keygen-start[279]: The key's randomart image is: machine1 # [38511.278820] machine1 sshd-keygen-start[279]: +--[ED25519 256]--+ machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | ..o+o | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | oo= + | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | .=+= . | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | o..=o | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | ..+ .So | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | .. .o+ E | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | ...oo.. . . . | machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | o=.+.. .o+o+.| machine1 # [38511.278820] machine1 sshd-keygen-start[279]: | ..+.o oo=*B..| machine1 # [38511.278820] machine1 sshd-keygen-start[279]: +----[SHA256]-----+ machine1 # [38511.281047] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully. machine1 # [38511.281361] machine1 systemd[1]: Finished SSH Host Keys Generation. machine1 # [38511.281718] machine1 systemd[1]: sshd-keygen.service: Consumed 2.920s CPU time over 1.467s wall clock time. machine1 # [38511.283664] machine1 systemd[1]: Starting SSH Daemon... machine2 # [38511.055431] machine2 dbus-broker-launch[269]: Looking up NSS user entry for 'systemd-timesync'... machine2 # [38511.056518] machine2 dbus-broker-launch[269]: NSS returned no entry for 'systemd-timesync' machine2 # [38511.056518] machine2 dbus-broker-launch[269]: Invalid user-name in /nix/store/117ipki1i6mq7adbixr3qzj08nbnvv1d-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine2 # [38511.056916] machine2 systemd[1]: Started D-Bus System Message Bus. machine2 # [38511.064530] machine2 dbus-broker-launch[269]: Ready machine1: (finished: must succeed: systemctl status sshd, in 2.66 seconds) machine2: must succeed: systemctl status sshd machine1 # [38511.346949] machine1 sshd[281]: Server listening on 0.0.0.0 port 22. machine1 # [38511.346989] machine1 sshd[281]: Server listening on :: port 22. machine1 # [38511.347234] machine1 systemd[1]: Started SSH Daemon. machine1 # [38511.347554] machine1 systemd[1]: Reached target Multi-User System. machine1 # [38511.347832] machine1 systemd[1]: Startup finished in 2.076s. machine2: (finished: must succeed: systemctl status sshd, in 0.65 seconds) machine1: waiting for unit sshd machine1: (finished: waiting for unit sshd, in 0.02 seconds) machine2: waiting for unit sshd machine2 # [38511.844692] machine2 sshd-keygen-start[187]: Generating public/private rsa key pair. machine2 # [38511.844692] machine2 sshd-keygen-start[187]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key machine2 # [38511.844692] machine2 sshd-keygen-start[187]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub machine2 # [38511.844692] machine2 sshd-keygen-start[187]: The key fingerprint is: machine2 # [38511.844692] machine2 sshd-keygen-start[187]: SHA256:nrzALGlRL40LXZHP47gR391xRpP4CfhJkZjzryV0CuM root@machine2 machine2 # [38511.844692] machine2 sshd-keygen-start[187]: The key's randomart image is: machine2 # [38511.844692] machine2 sshd-keygen-start[187]: +---[RSA 4096]----+ machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | .. +.+ .| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | .. = = o.| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | . .o = +.o| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | o =. +o = =o| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | o + S=.o+.+oo| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | * =o.oE.o.o.| machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | + = +o + | machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | . . ... . | machine2 # [38511.844692] machine2 sshd-keygen-start[187]: | . | machine2 # [38511.844692] machine2 sshd-keygen-start[187]: +----[SHA256]-----+ machine2 # [38511.861898] machine2 sshd-keygen-start[279]: Generating public/private ed25519 key pair. machine2 # [38511.861898] machine2 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key machine2 # [38511.861898] machine2 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub machine2 # [38511.861898] machine2 sshd-keygen-start[279]: The key fingerprint is: machine2 # [38511.861898] machine2 sshd-keygen-start[279]: SHA256:DKJtq6IfLMQ/fSvnzznVdrdIx+ciBoa6U5jdDhwvCgY root@machine2 machine2 # [38511.861898] machine2 sshd-keygen-start[279]: The key's randomart image is: machine2 # [38511.861898] machine2 sshd-keygen-start[279]: +--[ED25519 256]--+ machine2 # [38511.861898] machine2 sshd-keygen-start[279]: | | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: | | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: | . . | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: |. Eo . o. | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: | o..o =S= . . | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: |....+.o B =. + +o| machine2 # [38511.861898] machine2 sshd-keygen-start[279]: |. o+.o = =..o +.+| machine2 # [38511.861898] machine2 sshd-keygen-start[279]: |.. o..=.o.o o....| machine2 # [38511.861898] machine2 sshd-keygen-start[279]: |ooo ==.+.. . . | machine2 # [38511.861898] machine2 sshd-keygen-start[279]: +----[SHA256]-----+ machine2 # [38511.863402] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully. machine2 # [38511.863510] machine2 systemd[1]: Finished SSH Host Keys Generation. machine2 # [38511.865010] machine2 systemd[1]: Starting SSH Daemon... machine2 # [38511.927038] machine2 sshd[281]: Server listening on 0.0.0.0 port 22. machine2 # [38511.927072] machine2 sshd[281]: Server listening on :: port 22. machine2 # [38511.927257] machine2 systemd[1]: Started SSH Daemon. machine2 # [38511.927557] machine2 systemd[1]: Reached target Multi-User System. machine2 # [38511.927777] machine2 systemd[1]: Startup finished in 2.695s. machine2: (finished: waiting for unit sshd, in 0.02 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.38 seconds) test script finished in 3.45s cleanup kill NspawnMachine (pid 52) kill NspawnMachine (pid 53) Container machine1 terminated by signal KILL. (finished: cleanup, in 0.28 seconds) Container machine2 terminated by signal KILL.