container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #529
· 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 machine2 on /build/vm-state-machine2.25░ Spawning container machine1 on /build/vm-state-machine1.26machine2 # [7073071.492318] machine2 systemd-journald[54]: Journal started27machine1 # [7073071.491397] machine1 systemd-journald[54]: Journal started28machine2 # [7073071.492384] machine2 systemd-journald[54]: Runtime Journal (/run/log/journal/5ccec52391cf42e1be6016d635b561ed) is 8M, max 2.5G, 2.4G free.29machine1 # [7073071.491449] machine1 systemd-journald[54]: Runtime Journal (/run/log/journal/1f386696bd1d43b9b643c9bec27980e0) is 8M, max 2.5G, 2.4G free.30machine2 # [7073071.498837] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...31machine1 # [7073071.498486] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...32machine2 # [7073071.499570] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...33machine1 # [7073071.499196] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...34machine2 # [7073071.510194] machine2 systemd-journald[54]: Time spent on flushing to /var/log/journal/5ccec52391cf42e1be6016d635b561ed is 1.145ms for 4 entries.35machine1 # [7073071.509581] machine1 systemd-journald[54]: Time spent on flushing to /var/log/journal/1f386696bd1d43b9b643c9bec27980e0 is 1.275ms for 4 entries.36machine2 # [7073071.510194] machine2 systemd-journald[54]: System Journal (/var/log/journal/5ccec52391cf42e1be6016d635b561ed) is 8M, max 4G, 3.9G free.37machine1 # [7073071.509581] machine1 systemd-journald[54]: System Journal (/var/log/journal/1f386696bd1d43b9b643c9bec27980e0) is 8M, max 4G, 3.9G free.38machine2 # [7073071.513911] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.39machine1 # [7073071.512669] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.40machine2 # [7073071.514145] machine2 systemd[1]: Reached target Preparation for Local File Systems.41machine1 # [7073071.512940] machine1 systemd[1]: Reached target Preparation for Local File Systems.42machine2 # [7073071.514226] machine2 systemd[1]: Reached target Local File Systems.43machine1 # [7073071.513029] machine1 systemd[1]: Reached target Local File Systems.44machine2 # [7073071.514929] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.45machine1 # [7073071.513739] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.46machine2 # [7073071.514973] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container47machine1 # [7073071.513782] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container48machine2 # [7073071.515693] machine2 systemd[1]: Starting Save Transient machine-id to Disk...49machine1 # [7073071.514648] machine1 systemd[1]: Starting Save Transient machine-id to Disk...50machine2 # [7073071.515727] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys51machine1 # [7073071.514687] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys52machine2 # [7073071.527733] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.53machine1 # [7073071.527216] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.54machine2 # [7073071.529082] machine2 systemd[1]: Starting Create System Files and Directories...55machine1 # [7073071.529306] machine1 systemd[1]: Starting Create System Files and Directories...56machine2 # [7073071.545872] machine2 systemd-tmpfiles[95]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted57machine1 # [7073071.546301] machine1 systemd-tmpfiles[97]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted58machine2 # [7073071.546092] machine2 systemd-tmpfiles[95]: fchmod() of /var/log/journal failed: Operation not permitted59machine1 # [7073071.546537] machine1 systemd-tmpfiles[97]: fchmod() of /var/log/journal failed: Operation not permitted60machine2 # [7073071.546242] machine2 systemd-tmpfiles[95]: fchmod() of /var/log/journal/5ccec52391cf42e1be6016d635b561ed failed: Operation not permitted61machine1 # [7073071.546701] machine1 systemd-tmpfiles[97]: fchmod() of /var/log/journal/1f386696bd1d43b9b643c9bec27980e0 failed: Operation not permitted62machine2 # [7073071.546477] machine2 systemd-tmpfiles[95]: fchmod() of /run/log/journal failed: Operation not permitted63machine1 # [7073071.546964] machine1 systemd-tmpfiles[97]: fchmod() of /run/log/journal failed: Operation not permitted64machine2 # [7073071.547961] machine2 systemd[1]: Finished Create System Files and Directories.65machine1 # [7073071.548360] machine1 systemd[1]: Finished Create System Files and Directories.66machine2 # [7073071.549104] machine2 systemd[1]: Starting Rebuild Journal Catalog...67machine1 # [7073071.549346] machine1 systemd[1]: Starting Rebuild Journal Catalog...68machine2 # [7073071.549853] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...69machine1 # [7073071.550036] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...70machine2 # [7073071.560566] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.71machine1 # [7073071.561805] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.72machine2 # [7073071.567623] machine2 systemd[1]: Finished Rebuild Journal Catalog.73machine1 # [7073071.567643] machine1 systemd[1]: Finished Rebuild Journal Catalog.74machine2 # [7073071.568654] machine2 systemd[1]: Starting Update is Completed...75machine1 # [7073071.568671] machine1 systemd[1]: Starting Update is Completed...76machine2 # [7073071.578953] machine2 systemd[1]: Finished Update is Completed.77machine1 # [7073071.578641] machine1 systemd[1]: Finished Update is Completed.78machine2 # [7073071.579057] machine2 systemd[1]: Reached target System Initialization.79machine1 # [7073071.578799] machine1 systemd[1]: Reached target System Initialization.80machine2 # [7073071.579130] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container81machine1 # [7073071.578884] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container82machine2 # [7073071.579163] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.83machine1 # [7073071.578918] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.84machine2 # [7073071.579182] machine2 systemd[1]: Reached target Timer Units.85machine1 # [7073071.578941] machine1 systemd[1]: Reached target Timer Units.86machine2 # [7073071.579284] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.87machine1 # [7073071.579045] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.88machine2 # [7073071.579399] machine2 systemd[1]: Listening on Nix Daemon Socket.89machine1 # [7073071.579168] machine1 systemd[1]: Listening on Nix Daemon Socket.90machine2 # [7073071.580369] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).91machine1 # [7073071.580146] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).92machine2 # [7073071.581211] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).93machine1 # [7073071.580974] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).94machine2 # [7073071.581298] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.95machine1 # [7073071.581064] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.96machine1 # [7073071.581085] machine1 systemd[1]: Reached target Socket Units.97machine2 # [7073071.581319] machine2 systemd[1]: Reached target Socket Units.98machine1 # [7073071.581130] machine1 systemd[1]: Reached target Basic System.99machine2 # [7073071.581359] machine2 systemd[1]: Reached target Basic System.100machine1 # [7073071.582121] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...101machine2 # [7073071.582257] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...102machine1 # [7073071.582951] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...103machine2 # [7073071.582981] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...104machine1 # [7073071.583686] machine1 systemd[1]: Starting SSH Host Keys Generation...105machine2 # [7073071.583679] machine2 systemd[1]: Starting SSH Host Keys Generation...106machine1 # [7073071.600911] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.107machine2 # [7073071.601038] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.108machine1 # [7073071.632506] machine1 systemd[1]: Finished Firewall.109machine2 # [7073071.634963] machine2 systemd[1]: Finished Firewall.110machine1 # [7073071.632662] machine1 systemd[1]: Reached target Preparation for Network.111machine2 # [7073071.635130] machine2 systemd[1]: Reached target Preparation for Network.112machine1 # [7073071.633538] machine1 systemd[1]: Starting Address configuration of eth1...113machine2 # [7073071.636119] machine2 systemd[1]: Starting Address configuration of eth1...114machine1 # [7073071.634321] machine1 systemd[1]: Starting Extra networking commands....115machine2 # [7073071.636979] machine2 systemd[1]: Starting Extra networking commands....116machine1 # [7073071.641224] machine1 systemd[1]: Finished Save Transient machine-id to Disk.117machine2 # [7073071.640751] machine2 systemd[1]: Finished Save Transient machine-id to Disk.118machine1 # [7073071.650610] machine1 network-addresses-eth1-start[178]: adding address 192.168.1.1/24... done119machine2 # [7073071.653721] machine2 network-addresses-eth1-start[178]: adding address 192.168.1.2/24... done120machine1 # [7073071.653298] machine1 network-addresses-eth1-start[178]: adding address 2001:db8:1::1/64... done121machine2 # [7073071.657010] machine2 network-addresses-eth1-start[178]: adding address 2001:db8:1::2/64... done122machine1 # [7073071.657084] machine1 systemd[1]: Finished Address configuration of eth1.123machine2 # [7073071.658268] machine2 nsncd[135]: Aug 29 20:08:17.711 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"124machine1 # [7073071.665361] machine1 nsncd[136]: Aug 29 20:08:17.718 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"125machine2 # [7073071.658415] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).126machine1 # [7073071.665705] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).127machine2 # [7073071.658473] machine2 systemd[1]: Reached target Host and Network Name Lookups.128machine1 # [7073071.665783] machine1 systemd[1]: Reached target Host and Network Name Lookups.129machine2 # [7073071.658547] machine2 systemd[1]: Reached target User and Group Name Lookups.130machine1 # [7073071.665919] machine1 systemd[1]: Reached target User and Group Name Lookups.131machine1 # [7073071.667096] machine1 systemd[1]: Starting User Login Management...132machine2 # [7073071.659680] machine2 systemd[1]: Starting User Login Management...133machine1 # [7073071.692253] machine1 systemd[1]: Stopped target Host and Network Name Lookups.134machine2 # [7073071.661393] machine2 systemd[1]: Finished Address configuration of eth1.135machine1 # [7073071.692316] machine1 systemd[1]: Stopping Host and Network Name Lookups...136machine2 # [7073071.691044] machine2 systemd[1]: Stopped target Host and Network Name Lookups.137machine1 # [7073071.692356] machine1 systemd[1]: Stopped target User and Group Name Lookups.138machine2 # [7073071.691102] machine2 systemd[1]: Stopping Host and Network Name Lookups...139machine1 # [7073071.692378] machine1 systemd[1]: Stopping User and Group Name Lookups...140machine2 # [7073071.691143] machine2 systemd[1]: Stopped target User and Group Name Lookups.141machine1 # [7073071.692550] machine1 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...142machine2 # [7073071.691165] machine2 systemd[1]: Stopping User and Group Name Lookups...143machine1 # [7073071.695149] machine1 systemd[1]: nscd.service: Deactivated successfully.144machine2 # [7073071.691331] machine2 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...145machine1 # [7073071.695283] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).146machine2 # [7073071.694037] machine2 systemd[1]: nscd.service: Deactivated successfully.147machine1 # [7073071.697240] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...148machine2 # [7073071.694181] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).149machine1 # [7073071.705071] machine1 systemd[1]: Finished Extra networking commands..150machine2 # [7073071.696415] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...151machine1 # [7073071.705222] machine1 systemd[1]: Reached target Network.152machine2 # [7073071.705480] machine2 systemd[1]: Finished Extra networking commands..153machine2 # [7073071.705623] machine2 systemd[1]: Reached target Network.154machine2 # [7073071.776577] machine2 nsncd[253]: Aug 29 20:08:17.829 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"155machine2 # [7073071.776640] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).156machine2 # [7073071.776692] machine2 systemd[1]: Reached target Host and Network Name Lookups.157machine2 # [7073071.776745] machine2 systemd[1]: Reached target User and Group Name Lookups.158machine2 # [7073071.816449] machine2 systemd[1]: Starting Permit User Sessions...159machine2 # [7073071.824957] machine2 systemd[1]: Finished Permit User Sessions.160machine2 # [7073071.825798] machine2 systemd[1]: Started Console Getty.161machine2 # [7073071.825833] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0162machine2 # [7073071.825850] machine2 systemd[1]: Reached target Login Prompts.163machine2 # [7073072.040050] machine2 systemd-logind[206]: New seat seat0.164machine2 # [7073072.040377] machine2 systemd[1]: Started User Login Management.165machine1 # [7073071.765284] machine1 nsncd[254]: Aug 29 20:08:17.818 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"166machine1 # [7073071.765384] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).167machine1 # [7073071.765441] machine1 systemd[1]: Reached target Host and Network Name Lookups.168machine1 # [7073071.765497] machine1 systemd[1]: Reached target User and Group Name Lookups.169machine1 # [7073071.766334] machine1 systemd[1]: Starting Permit User Sessions...170machine1 # [7073071.822933] machine1 systemd[1]: Finished Permit User Sessions.171machine1 # [7073071.823984] machine1 systemd[1]: Started Console Getty.172machine1 # [7073071.824038] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0173machine1 # [7073071.824061] machine1 systemd[1]: Reached target Login Prompts.174machine2 # [7073072.042077] machine2 systemd[1]: Starting D-Bus System Message Bus...175machine2 # [7073072.043416] machine2 systemd[1]: Starting linger-users.service...176machine2 # [7073072.114818] machine2 systemd[1]: linger-users.service: Deactivated successfully.177machine2 # [7073072.114997] machine2 systemd[1]: Finished linger-users.service.178machine2 # [7073072.265900] machine2 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'...179machine2 # [7073072.267233] machine2 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync'180machine2 # [7073072.267233] machine2 dbus-broker-launch[276]: Invalid user-name in /nix/store/giz3li8apb3pvmikksynv3kdqgp6s3nz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"181machine2 # [7073072.267729] machine2 systemd[1]: Started D-Bus System Message Bus.182machine2 # [7073072.276130] machine2 dbus-broker-launch[276]: Ready183machine1 # [7073072.060685] machine1 systemd-logind[215]: New seat seat0.184machine1 # [7073072.060979] machine1 systemd[1]: Started User Login Management.185machine1 # [7073072.104486] machine1 systemd[1]: Starting D-Bus System Message Bus...186machine1 # [7073072.105834] machine1 systemd[1]: Starting linger-users.service...187machine1 # [7073072.118601] machine1 systemd[1]: linger-users.service: Deactivated successfully.188machine1 # [7073072.118690] machine1 systemd[1]: Finished linger-users.service.189machine1 # [7073072.294827] machine1 dbus-broker-launch[276]: Looking up NSS user entry for 'systemd-timesync'...190machine1 # [7073072.295825] machine1 dbus-broker-launch[276]: NSS returned no entry for 'systemd-timesync'191machine1 # [7073072.295825] machine1 dbus-broker-launch[276]: Invalid user-name in /nix/store/giz3li8apb3pvmikksynv3kdqgp6s3nz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"192machine1 # [7073072.296288] machine1 systemd[1]: Started D-Bus System Message Bus.193machine1 # [7073072.306135] machine1 dbus-broker-launch[276]: Ready194machine1 # [7073072.482274] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.195machine2 # [7073072.485823] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.196machine1: (finished: must succeed: systemctl status sshd, in 2.66 seconds)197machine2: must succeed: systemctl status sshd198machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: Generating public/private rsa key pair.199machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key200machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub201machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: The key fingerprint is:202machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: SHA256:pcl6K82G9bgoHGWjcRGhbmoX5F54puhppcbKznPUAKQ root@machine1203machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: The key's randomart image is:204machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: +---[RSA 4096]----+205machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: |.. oo |206machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: |.. .. |207machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: |E . o . . |208machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: | =..=. + |209machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: | O*+.S |210machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: | *+B .. |211machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: | .=++..=.o |212machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: |o+=+o oo=.. |213machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: |oB= ..oo. |214machine1 # [7073073.054112] machine1 sshd-keygen-start[157]: +----[SHA256]-----+215machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: Generating public/private ed25519 key pair.216machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key217machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub218machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: The key fingerprint is:219machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: SHA256:LKm818S/qCpv8HXSi6sqN3k39Qb8A0f8AjlRtQ8D5zg root@machine1220machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: The key's randomart image is:221machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: +--[ED25519 256]--+222machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | .o.o |223machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | . = . |224machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | +E = |225machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | o+ o. + |226machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | o+S+ . . |227machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | .. .o.X o . |228machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | +o. B O . |229machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: |. = +.= o.* |230machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: | o.B==o+...o |231machine1 # [7073073.069880] machine1 sshd-keygen-start[286]: +----[SHA256]-----+232machine1 # [7073073.070928] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.233machine1 # [7073073.071095] machine1 systemd[1]: Finished SSH Host Keys Generation.234machine1 # [7073073.071286] machine1 systemd[1]: sshd-keygen.service: Consumed 2.967s CPU time over 1.487s wall clock time.235machine1 # [7073073.073076] machine1 systemd[1]: Starting SSH Daemon...236machine1 # [7073073.166346] machine1 sshd[288]: Server listening on 0.0.0.0 port 22.237machine1 # [7073073.166377] machine1 sshd[288]: Server listening on :: port 22.238machine1 # [7073073.166556] machine1 systemd[1]: Started SSH Daemon.239machine1 # [7073073.166854] machine1 systemd[1]: Reached target Multi-User System.240machine1 # [7073073.167313] machine1 systemd[1]: Startup finished in 2.008s.241machine2: (finished: must succeed: systemctl status sshd, in 0.33 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 3.05 seconds)253machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: Generating public/private rsa key pair.254machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key255machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub256machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: The key fingerprint is:257machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: SHA256:eOH1c2nzS1V0jakg3U66VJKg5l5dZ+H4i0/QZDTqorM root@machine2258machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: The key's randomart image is:259machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: +---[RSA 4096]----+260machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | .o o +o+|261machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | .. = +=o+o|262machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | o ...B+.* .|263machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | o o +o+oB ..|264machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | o S.o.= B .|265machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | . o ... * +.|266machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | . o . o..|267machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | o o. .|268machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: | E .. |269machine2 # [7073073.522273] machine2 sshd-keygen-start[154]: +----[SHA256]-----+270machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: Generating public/private ed25519 key pair.271machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key272machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub273machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: The key fingerprint is:274machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: SHA256:HweSVBxZl3BZokFITbiOR1ty/7PGwggbernBPn66NB4 root@machine2275machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: The key's randomart image is:276machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: +--[ED25519 256]--+277machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | .++X*.++.|278machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | . .= .=o. |279machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | o ... |280machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | .+.o |281machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | S+.=.. |282machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | o++o . |283machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | .E* o .. |284machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | .+=+o o +.|285machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: | oB* o.o|286machine2 # [7073073.539619] machine2 sshd-keygen-start[286]: +----[SHA256]-----+287machine2 # [7073073.541252] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.288machine2 # [7073073.541354] machine2 systemd[1]: Finished SSH Host Keys Generation.289machine2 # [7073073.542542] machine2 systemd[1]: Starting SSH Daemon...290machine2 # [7073073.600493] machine2 sshd[288]: Server listening on 0.0.0.0 port 22.291machine2 # [7073073.600525] machine2 sshd[288]: Server listening on :: port 22.292machine2 # [7073073.600703] machine2 systemd[1]: Started SSH Daemon.293machine2 # [7073073.601047] machine2 systemd[1]: Reached target Multi-User System.294machine2 # [7073073.601255] machine2 systemd[1]: Startup finished in 2.442s.295test script finished in 3.42s296cleanup297kill NspawnMachine (pid 52)298kill NspawnMachine (pid 53)299Container machine1 terminated by signal KILL.300Container machine2 terminated by signal KILL.301(finished: cleanup, in 0.43 seconds)