container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #582
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)45Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 machine1, machine2,9 vlan1,10 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_ssh11start all VMs12machine1: systemd-nspawn running (pid 52)13machine2: systemd-nspawn running (pid 53)14machine1: Waiting for journal at /build/vm-state-machine1/var/log/journal...15machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal...16(finished: start all VMs, in 0.00 seconds)17machine1: must succeed: systemctl status sshd18nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE19nixos-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.20nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE21nixos-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.22Note: 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.23Note: 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.24░ Spawning container machine1 on /build/vm-state-machine1.25░ Spawning container machine2 on /build/vm-state-machine2.26machine1 # [27696.165916] machine1 systemd-journald[54]: Journal started27machine1 # [27696.165969] machine1 systemd-journald[54]: Runtime Journal (/run/log/journal/89c0591259e14160b8fde0138feecdf5) is 8M, max 2.5G, 2.4G free.28machine1 # [27696.169991] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...29machine1 # [27696.170742] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...30machine1 # [27696.178395] machine1 systemd-journald[54]: Time spent on flushing to /var/log/journal/89c0591259e14160b8fde0138feecdf5 is 1.516ms for 4 entries.31machine1 # [27696.178395] machine1 systemd-journald[54]: System Journal (/var/log/journal/89c0591259e14160b8fde0138feecdf5) is 8M, max 4G, 3.9G free.32machine1 # [27696.186067] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.33machine1 # [27696.186308] machine1 systemd[1]: Reached target Preparation for Local File Systems.34machine1 # [27696.186393] machine1 systemd[1]: Reached target Local File Systems.35machine1 # [27696.187124] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.36machine1 # [27696.187169] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container37machine1 # [27696.187931] machine1 systemd[1]: Starting Save Transient machine-id to Disk...38machine1 # [27696.187966] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys39machine1 # [27696.230032] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.40machine1 # [27696.231108] machine1 systemd[1]: Starting Create System Files and Directories...41machine1 # [27696.240739] machine1 systemd[1]: Finished Save Transient machine-id to Disk.42machine1 # [27696.250340] machine1 systemd-tmpfiles[109]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted43machine1 # [27696.250534] machine1 systemd-tmpfiles[109]: fchmod() of /var/log/journal failed: Operation not permitted44machine1 # [27696.250672] machine1 systemd-tmpfiles[109]: fchmod() of /var/log/journal/89c0591259e14160b8fde0138feecdf5 failed: Operation not permitted45machine1 # [27696.250887] machine1 systemd-tmpfiles[109]: fchmod() of /run/log/journal failed: Operation not permitted46machine1 # [27696.252304] machine1 systemd[1]: Finished Create System Files and Directories.47machine1 # [27696.253727] machine1 systemd[1]: Starting Rebuild Journal Catalog...48machine1 # [27696.254641] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...49machine1 # [27696.267747] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.50machine1 # [27696.274900] machine1 systemd[1]: Finished Rebuild Journal Catalog.51machine1 # [27696.276175] machine1 systemd[1]: Starting Update is Completed...52machine1 # [27696.285642] machine1 systemd[1]: Finished Update is Completed.53machine1 # [27696.285836] machine1 systemd[1]: Reached target System Initialization.54machine1 # [27696.285933] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container55machine1 # [27696.285970] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.56machine1 # [27696.285995] machine1 systemd[1]: Reached target Timer Units.57machine1 # [27696.286118] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.58machine1 # [27696.286276] machine1 systemd[1]: Listening on Nix Daemon Socket.59machine1 # [27696.287552] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).60machine1 # [27696.288670] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).61machine1 # [27696.288794] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.62machine1 # [27696.288821] machine1 systemd[1]: Reached target Socket Units.63machine1 # [27696.288875] machine1 systemd[1]: Reached target Basic System.64machine1 # [27696.289951] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...65machine2 # [27696.158329] machine2 systemd-journald[54]: Journal started66machine1 # [27696.290824] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...67machine2 # [27696.158387] machine2 systemd-journald[54]: Runtime Journal (/run/log/journal/a4e8fd8d8d16460c944649f398101df9) is 8M, max 2.5G, 2.4G free.68machine1 # [27696.291554] machine1 systemd[1]: Starting SSH Host Keys Generation...69machine2 # [27696.163469] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...70machine1 # [27696.309450] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.71machine2 # [27696.164181] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...72machine1 # [27696.319714] machine1 systemd[1]: Finished Firewall.73machine2 # [27696.173849] machine2 systemd-journald[54]: Time spent on flushing to /var/log/journal/a4e8fd8d8d16460c944649f398101df9 is 1.455ms for 4 entries.74machine1 # [27696.319894] machine1 systemd[1]: Reached target Preparation for Network.75machine2 # [27696.173849] machine2 systemd-journald[54]: System Journal (/var/log/journal/a4e8fd8d8d16460c944649f398101df9) is 8M, max 4G, 3.9G free.76machine1 # [27696.320840] machine1 systemd[1]: Starting Address configuration of eth1...77machine2 # [27696.177306] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.78machine1 # [27696.321713] machine1 systemd[1]: Starting Extra networking commands....79machine2 # [27696.177563] machine2 systemd[1]: Reached target Preparation for Local File Systems.80machine2 # [27696.177642] machine2 systemd[1]: Reached target Local File Systems.81machine2 # [27696.178369] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.82machine2 # [27696.178414] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container83machine2 # [27696.179237] machine2 systemd[1]: Starting Save Transient machine-id to Disk...84machine2 # [27696.179270] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys85machine2 # [27696.229824] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.86machine2 # [27696.231161] machine2 systemd[1]: Starting Create System Files and Directories...87machine2 # [27696.240368] machine2 systemd[1]: Finished Save Transient machine-id to Disk.88machine2 # [27696.247845] machine2 systemd-tmpfiles[113]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted89machine2 # [27696.248432] machine2 systemd-tmpfiles[113]: fchmod() of /var/log/journal failed: Operation not permitted90machine2 # [27696.248576] machine2 systemd-tmpfiles[113]: fchmod() of /var/log/journal/a4e8fd8d8d16460c944649f398101df9 failed: Operation not permitted91machine2 # [27696.248791] machine2 systemd-tmpfiles[113]: fchmod() of /run/log/journal failed: Operation not permitted92machine2 # [27696.250085] machine2 systemd[1]: Finished Create System Files and Directories.93machine2 # [27696.251125] machine2 systemd[1]: Starting Rebuild Journal Catalog...94machine2 # [27696.251813] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...95machine2 # [27696.264766] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.96machine2 # [27696.271907] machine2 systemd[1]: Finished Rebuild Journal Catalog.97machine2 # [27696.272949] machine2 systemd[1]: Starting Update is Completed...98machine2 # [27696.282912] machine2 systemd[1]: Finished Update is Completed.99machine2 # [27696.283082] machine2 systemd[1]: Reached target System Initialization.100machine2 # [27696.283165] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container101machine2 # [27696.283199] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.102machine2 # [27696.283219] machine2 systemd[1]: Reached target Timer Units.103machine2 # [27696.283326] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.104machine2 # [27696.283449] machine2 systemd[1]: Listening on Nix Daemon Socket.105machine2 # [27696.284472] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).106machine2 # [27696.285331] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).107machine2 # [27696.285431] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.108machine2 # [27696.285451] machine2 systemd[1]: Reached target Socket Units.109machine2 # [27696.285484] machine2 systemd[1]: Reached target Basic System.110machine2 # [27696.286460] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...111machine2 # [27696.287254] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...112machine2 # [27696.287928] machine2 systemd[1]: Starting SSH Host Keys Generation...113machine2 # [27696.303889] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.114machine2 # [27696.313743] machine2 systemd[1]: Finished Firewall.115machine2 # [27696.313919] machine2 systemd[1]: Reached target Preparation for Network.116machine2 # [27696.314863] machine2 systemd[1]: Starting Address configuration of eth1...117machine2 # [27696.315913] machine2 systemd[1]: Starting Extra networking commands....118machine2 # [27696.331784] machine2 network-addresses-eth1-start[179]: adding address 192.168.1.2/24... done119machine2 # [27696.334202] machine2 network-addresses-eth1-start[179]: adding address 2001:db8:1::2/64... done120machine2 # [27696.338759] machine2 systemd[1]: Finished Address configuration of eth1.121machine2 # [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"122machine2 # [27696.354882] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).123machine2 # [27696.354949] machine2 systemd[1]: Reached target Host and Network Name Lookups.124machine2 # [27696.355005] machine2 systemd[1]: Reached target User and Group Name Lookups.125machine2 # [27696.356171] machine2 systemd[1]: Starting User Login Management...126machine2 # [27696.378268] machine2 systemd[1]: Stopped target Host and Network Name Lookups.127machine2 # [27696.378326] machine2 systemd[1]: Stopping Host and Network Name Lookups...128machine2 # [27696.378374] machine2 systemd[1]: Stopped target User and Group Name Lookups.129machine2 # [27696.378400] machine2 systemd[1]: Stopping User and Group Name Lookups...130machine2 # [27696.379481] machine2 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...131machine2 # [27696.382305] machine2 systemd[1]: nscd.service: Deactivated successfully.132machine2 # [27696.382380] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).133machine2 # [27696.384586] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...134machine2 # [27696.394057] machine2 systemd[1]: Finished Extra networking commands..135machine2 # [27696.394240] machine2 systemd[1]: Reached target Network.136machine2 # [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"137machine2 # [27696.456345] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).138machine2 # [27696.456401] machine2 systemd[1]: Reached target Host and Network Name Lookups.139machine2 # [27696.456457] machine2 systemd[1]: Reached target User and Group Name Lookups.140machine1 # [27696.336869] machine1 network-addresses-eth1-start[179]: adding address 192.168.1.1/24... done141machine1 # [27696.339829] machine1 network-addresses-eth1-start[179]: adding address 2001:db8:1::1/64... done142machine1 # [27696.344267] machine1 systemd[1]: Finished Address configuration of eth1.143machine1 # [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"144machine1 # [27696.356344] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).145machine1 # [27696.356414] machine1 systemd[1]: Reached target Host and Network Name Lookups.146machine1 # [27696.356478] machine1 systemd[1]: Reached target User and Group Name Lookups.147machine1 # [27696.357653] machine1 systemd[1]: Starting User Login Management...148machine1 # [27696.377907] machine1 systemd[1]: Stopped target Host and Network Name Lookups.149machine1 # [27696.377967] machine1 systemd[1]: Stopping Host and Network Name Lookups...150machine1 # [27696.378007] machine1 systemd[1]: Stopped target User and Group Name Lookups.151machine1 # [27696.378031] machine1 systemd[1]: Stopping User and Group Name Lookups...152machine1 # [27696.378181] machine1 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...153machine1 # [27696.382062] machine1 systemd[1]: nscd.service: Deactivated successfully.154machine1 # [27696.382240] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).155machine1 # [27696.384454] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...156machine1 # [27696.393320] machine1 systemd[1]: Finished Extra networking commands..157machine1 # [27696.393508] machine1 systemd[1]: Reached target Network.158machine2 # [27696.457432] machine2 systemd[1]: Starting Permit User Sessions...159machine2 # [27696.499443] machine2 systemd[1]: Finished Permit User Sessions.160machine2 # [27696.501035] machine2 systemd[1]: Started Console Getty.161machine2 # [27696.501106] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0162machine2 # [27696.501143] machine2 systemd[1]: Reached target Login Prompts.163machine1 # [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"164machine1 # [27696.458911] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).165machine1 # [27696.458970] machine1 systemd[1]: Reached target Host and Network Name Lookups.166machine1 # [27696.459029] machine1 systemd[1]: Reached target User and Group Name Lookups.167machine1 # [27696.459833] machine1 systemd[1]: Starting Permit User Sessions...168machine1 # [27696.499138] machine1 systemd[1]: Finished Permit User Sessions.169machine1 # [27696.500160] machine1 systemd[1]: Started Console Getty.170machine1 # [27696.500208] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0171machine1 # [27696.500226] machine1 systemd[1]: Reached target Login Prompts.172machine2 # [27696.758371] machine2 systemd-logind[220]: New seat seat0.173machine2 # [27696.800396] machine2 systemd[1]: Starting D-Bus System Message Bus...174machine1 # [27696.746759] machine1 systemd-logind[222]: New seat seat0.175machine2 # [27696.800486] machine2 systemd[1]: Started User Login Management.176machine1 # [27696.747840] machine1 systemd[1]: Starting D-Bus System Message Bus...177machine2 # [27696.801302] machine2 systemd[1]: Starting linger-users.service...178machine1 # [27696.747960] machine1 systemd[1]: Started User Login Management.179machine2 # [27696.813919] machine2 systemd[1]: linger-users.service: Deactivated successfully.180machine1 # [27696.748825] machine1 systemd[1]: Starting linger-users.service...181machine2 # [27696.813983] machine2 systemd[1]: Finished linger-users.service.182machine1 # [27696.812035] machine1 systemd[1]: linger-users.service: Deactivated successfully.183machine2 # [27696.931470] machine2 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'...184machine1 # [27696.812314] machine1 systemd[1]: Finished linger-users.service.185machine2 # [27696.932615] machine2 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync'186machine1 # [27696.928980] machine1 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'...187machine2 # [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"188machine1 # [27696.929772] machine1 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync'189machine2 # [27696.932993] machine2 systemd[1]: Started D-Bus System Message Bus.190machine1 # [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"191machine2 # [27696.939999] machine2 dbus-broker-launch[276]: Ready192machine1 # [27696.930154] machine1 systemd[1]: Started D-Bus System Message Bus.193machine2 # [27697.149469] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.194machine1 # [27696.937138] machine1 dbus-broker-launch[276]: Ready195machine1 # [27697.158882] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.196machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Generating public/private rsa key pair.197machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key198machine2 # [27697.548346] machine2 sshd-keygen-start[174]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub199machine2 # [27697.548346] machine2 sshd-keygen-start[174]: The key fingerprint is:200machine2 # [27697.548346] machine2 sshd-keygen-start[174]: SHA256:bHXjncKjBuozp4P8JHJKFQjWrso8LcUP4QYed/urBXo root@machine2201machine2 # [27697.548346] machine2 sshd-keygen-start[174]: The key's randomart image is:202machine2 # [27697.548346] machine2 sshd-keygen-start[174]: +---[RSA 4096]----+203machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |... |204machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |.. o |205machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o . . o |206machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o + o . . + o . |207machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |. B +.. S = o |208machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | o B...o . . o |209machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |+ *o=E+. o |210machine2 # [27697.548346] machine2 sshd-keygen-start[174]: |.* =+==... |211machine2 # [27697.548346] machine2 sshd-keygen-start[174]: | + o=B. |212machine2 # [27697.548346] machine2 sshd-keygen-start[174]: +----[SHA256]-----+213machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Generating public/private ed25519 key pair.214machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key215machine2 # [27697.565211] machine2 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub216machine2 # [27697.565211] machine2 sshd-keygen-start[286]: The key fingerprint is:217machine2 # [27697.565211] machine2 sshd-keygen-start[286]: SHA256:/91e6L3VwWAvhDs6e8ISR1takRrbnx+tfv4nPSbaaSQ root@machine2218machine2 # [27697.565211] machine2 sshd-keygen-start[286]: The key's randomart image is:219machine2 # [27697.565211] machine2 sshd-keygen-start[286]: +--[ED25519 256]--+220machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . |221machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . o. |222machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | =..+ |223machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | + ++ + |224machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | S =o...+.|225machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . =.E.+.o+|226machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | +o. o oo=|227machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | . ooo.=+**|228machine2 # [27697.565211] machine2 sshd-keygen-start[286]: | ..o.++**@|229machine2 # [27697.565211] machine2 sshd-keygen-start[286]: +----[SHA256]-----+230machine2 # [27697.566856] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.231machine2 # [27697.567026] machine2 systemd[1]: Finished SSH Host Keys Generation.232machine2 # [27697.567224] machine2 systemd[1]: sshd-keygen.service: Consumed 2.548s CPU time over 1.278s wall clock time.233machine2 # [27697.568395] machine2 systemd[1]: Starting SSH Daemon...234machine2 # [27697.607551] machine2 sshd[288]: Server listening on 0.0.0.0 port 22.235machine2 # [27697.607575] machine2 sshd[288]: Server listening on :: port 22.236machine2 # [27697.607701] machine2 systemd[1]: Started SSH Daemon.237machine2 # [27697.607970] machine2 systemd[1]: Reached target Multi-User System.238machine2 # [27697.608219] machine2 systemd[1]: Startup finished in 1.832s.239machine1: (finished: must succeed: systemctl status sshd, in 2.66 seconds)240machine2: must succeed: systemctl status sshd241machine2: (finished: must succeed: systemctl status sshd, in 0.01 seconds)242machine1: waiting for unit sshd243machine1: (finished: waiting for unit sshd, in 0.02 seconds)244machine2: waiting for unit sshd245machine2: (finished: waiting for unit sshd, in 0.01 seconds)246machine1: must succeed: ip addr show eth1247machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)248machine2: must succeed: ip addr show eth1249machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)250machine1: must succeed: ping -c 1 machine2251machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)252(finished: run the VM test script, in 2.73 seconds)253test script finished in 2.79s254cleanup255kill NspawnMachine (pid 52)256machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Generating public/private rsa key pair.257machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key258machine1 # [27697.854779] machine1 sshd-keygen-start[170]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub259machine1 # [27697.854779] machine1 sshd-keygen-start[170]: The key fingerprint is:260machine1 # [27697.854779] machine1 sshd-keygen-start[170]: SHA256:8cMnvhC1Q5KcUEoAk+RC1dB7QAjccUuldcnHv4KOrt8 root@machine1261machine1 # [27697.854779] machine1 sshd-keygen-start[170]: The key's randomart image is:262machine1 # [27697.854779] machine1 sshd-keygen-start[170]: +---[RSA 4096]----+263machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |.+B*O=++o.o |264machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |.o.+o=++.= o |265machine1 # [27697.854779] machine1 sshd-keygen-start[170]: |. . o+ * + . |266machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | . . . B . . |267machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | . S O . . |268machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | + * . |269machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | + . . |270machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | ..o . |271machine1 # [27697.854779] machine1 sshd-keygen-start[170]: | .+o E. |272machine1 # [27697.854779] machine1 sshd-keygen-start[170]: +----[SHA256]-----+273machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Generating public/private ed25519 key pair.274machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key275machine1 # [27697.870394] machine1 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub276machine1 # [27697.870394] machine1 sshd-keygen-start[286]: The key fingerprint is:277machine1 # [27697.870394] machine1 sshd-keygen-start[286]: SHA256:8r6BKM8sMWmGoLVINtiNRRRmZVeofvgTc/X8rNIzOjs root@machine1278machine1 # [27697.870394] machine1 sshd-keygen-start[286]: The key's randomart image is:279machine1 # [27697.870394] machine1 sshd-keygen-start[286]: +--[ED25519 256]--+280machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o*oo .o. |281machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o.. .. |282machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |.. + . |283machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |o++ . . . |284machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |=+.o ...S . o |285machine1 # [27697.870394] machine1 sshd-keygen-start[286]: |+ B .o++ . o |286machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | o.o. .oo+ . o |287machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | .= .o. E + o|288machine1 # [27697.870394] machine1 sshd-keygen-start[286]: | .+ oo o*.+ |289machine1 # [27697.870394] machine1 sshd-keygen-start[286]: +----[SHA256]-----+290machine1 # [27697.871634] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.291machine1 # [27697.871757] machine1 systemd[1]: Finished SSH Host Keys Generation.292machine1 # [27697.873929] machine1 systemd[1]: Starting SSH Daemon...293machine1 # [27697.916677] machine1 sshd[288]: Server listening on 0.0.0.0 port 22.294machine1 # [27697.916713] machine1 sshd[288]: Server listening on :: port 22.295machine1 # [27697.916899] machine1 systemd[1]: Started SSH Daemon.296machine1 # [27697.917337] machine1 systemd[1]: Reached target Multi-User System.297machine1 # [27697.917695] machine1 systemd[1]: Startup finished in 2.133s.298kill NspawnMachine (pid 53)299Container machine1 terminated by signal KILL.300Container machine2 terminated by signal KILL.301(finished: cleanup, in 0.33 seconds)