container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #500
· 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(machine1): TAP vde-tap1 not found; container will be isolated from VDE19nixos-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.20nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE21nixos-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.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 # [6727582.891832] machine2 systemd-journald[54]: Journal started27machine2 # [6727582.891906] machine2 systemd-journald[54]: Runtime Journal (/run/log/journal/55a6d152922d4c078cfb742137686a23) is 8M, max 2.5G, 2.4G free.28machine2 # [6727582.896929] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...29machine2 # [6727582.897920] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...30machine2 # [6727582.906597] machine2 systemd-journald[54]: Time spent on flushing to /var/log/journal/55a6d152922d4c078cfb742137686a23 is 1.326ms for 4 entries.31machine2 # [6727582.906597] machine2 systemd-journald[54]: System Journal (/var/log/journal/55a6d152922d4c078cfb742137686a23) is 8M, max 4G, 3.9G free.32machine2 # [6727582.926415] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.33machine2 # [6727582.926693] machine2 systemd[1]: Reached target Preparation for Local File Systems.34machine1 # [6727582.877515] machine1 systemd-journald[54]: Journal started35machine2 # [6727582.926773] machine2 systemd[1]: Reached target Local File Systems.36machine1 # [6727582.877564] machine1 systemd-journald[54]: Runtime Journal (/run/log/journal/6767c3a6f65048a38bcbbbf4265f6574) is 8M, max 2.5G, 2.4G free.37machine2 # [6727582.927531] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.38machine1 # [6727582.883906] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...39machine2 # [6727582.927576] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container40machine1 # [6727582.884564] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...41machine2 # [6727582.928431] machine2 systemd[1]: Starting Save Transient machine-id to Disk...42machine1 # [6727582.894863] machine1 systemd-journald[54]: Time spent on flushing to /var/log/journal/6767c3a6f65048a38bcbbbf4265f6574 is 1.611ms for 4 entries.43machine2 # [6727582.928465] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys44machine1 # [6727582.894863] machine1 systemd-journald[54]: System Journal (/var/log/journal/6767c3a6f65048a38bcbbbf4265f6574) is 8M, max 4G, 3.9G free.45machine2 # [6727582.985875] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.46machine1 # [6727582.898893] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.47machine2 # [6727582.987669] machine2 systemd[1]: Starting Create System Files and Directories...48machine1 # [6727582.899103] machine1 systemd[1]: Reached target Preparation for Local File Systems.49machine2 # [6727583.043154] machine2 systemd[1]: Finished Firewall.50machine1 # [6727582.899175] machine1 systemd[1]: Reached target Local File Systems.51machine2 # [6727583.043324] machine2 systemd[1]: Reached target Preparation for Network.52machine1 # [6727582.899864] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.53machine2 # [6727583.047749] machine2 systemd-tmpfiles[127]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted54machine1 # [6727582.899905] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container55machine2 # [6727583.047927] machine2 systemd-tmpfiles[127]: fchmod() of /var/log/journal failed: Operation not permitted56machine1 # [6727582.900676] machine1 systemd[1]: Starting Save Transient machine-id to Disk...57machine2 # [6727583.048061] machine2 systemd-tmpfiles[127]: fchmod() of /var/log/journal/55a6d152922d4c078cfb742137686a23 failed: Operation not permitted58machine1 # [6727582.900706] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys59machine2 # [6727583.048248] machine2 systemd-tmpfiles[127]: fchmod() of /run/log/journal failed: Operation not permitted60machine1 # [6727582.987008] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.61machine2 # [6727583.049498] machine2 systemd[1]: Finished Create System Files and Directories.62machine1 # [6727582.988171] machine1 systemd[1]: Starting Create System Files and Directories...63machine2 # [6727583.050554] machine2 systemd[1]: Starting Rebuild Journal Catalog...64machine1 # [6727583.043778] machine1 systemd[1]: Finished Firewall.65machine2 # [6727583.051262] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...66machine1 # [6727583.043915] machine1 systemd[1]: Reached target Preparation for Network.67machine2 # [6727583.066038] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.68machine1 # [6727583.049875] machine1 systemd-tmpfiles[128]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted69machine2 # [6727583.073052] machine2 systemd[1]: Finished Rebuild Journal Catalog.70machine1 # [6727583.050093] machine1 systemd-tmpfiles[128]: fchmod() of /var/log/journal failed: Operation not permitted71machine2 # [6727583.074895] machine2 systemd[1]: Starting Update is Completed...72machine1 # [6727583.050248] machine1 systemd-tmpfiles[128]: fchmod() of /var/log/journal/6767c3a6f65048a38bcbbbf4265f6574 failed: Operation not permitted73machine2 # [6727583.085487] machine2 systemd[1]: Finished Update is Completed.74machine1 # [6727583.050481] machine1 systemd-tmpfiles[128]: fchmod() of /run/log/journal failed: Operation not permitted75machine2 # [6727583.085662] machine2 systemd[1]: Reached target System Initialization.76machine1 # [6727583.052085] machine1 systemd[1]: Finished Create System Files and Directories.77machine2 # [6727583.085749] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container78machine1 # [6727583.053424] machine1 systemd[1]: Starting Rebuild Journal Catalog...79machine2 # [6727583.085788] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.80machine1 # [6727583.054265] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...81machine2 # [6727583.085812] machine2 systemd[1]: Reached target Timer Units.82machine1 # [6727583.067258] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.83machine2 # [6727583.085937] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.84machine1 # [6727583.077397] machine1 systemd[1]: Finished Rebuild Journal Catalog.85machine2 # [6727583.086074] machine2 systemd[1]: Listening on Nix Daemon Socket.86machine1 # [6727583.078365] machine1 systemd[1]: Starting Update is Completed...87machine2 # [6727583.087404] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).88machine2 # [6727583.088687] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).89machine2 # [6727583.088815] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.90machine2 # [6727583.088843] machine2 systemd[1]: Reached target Socket Units.91machine2 # [6727583.088891] machine2 systemd[1]: Reached target Basic System.92machine2 # [6727583.090006] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...93machine2 # [6727583.090802] machine2 systemd[1]: Starting Address configuration of eth1...94machine2 # [6727583.091667] machine2 systemd[1]: Starting Extra networking commands....95machine2 # [6727583.092560] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...96machine2 # [6727583.093356] machine2 systemd[1]: Starting SSH Host Keys Generation...97machine2 # [6727583.109361] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.98machine2 # [6727583.109585] machine2 network-addresses-eth1-start[166]: adding address 192.168.1.2/24... done99machine2 # [6727583.113351] machine2 network-addresses-eth1-start[166]: adding address 2001:db8:1::2/64... done100machine2 # [6727583.117820] machine2 systemd[1]: Finished Address configuration of eth1.101machine1 # [6727583.088325] machine1 systemd[1]: Finished Update is Completed.102machine1 # [6727583.088524] machine1 systemd[1]: Reached target System Initialization.103machine1 # [6727583.088619] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container104machine1 # [6727583.088659] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.105machine1 # [6727583.088685] machine1 systemd[1]: Reached target Timer Units.106machine1 # [6727583.088818] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.107machine1 # [6727583.088965] machine1 systemd[1]: Listening on Nix Daemon Socket.108machine1 # [6727583.090394] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).109machine1 # [6727583.091680] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).110machine1 # [6727583.091803] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.111machine1 # [6727583.091834] machine1 systemd[1]: Reached target Socket Units.112machine1 # [6727583.091893] machine1 systemd[1]: Reached target Basic System.113machine1 # [6727583.093072] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...114machine1 # [6727583.093955] machine1 systemd[1]: Starting Address configuration of eth1...115machine1 # [6727583.094849] machine1 systemd[1]: Starting Extra networking commands....116machine1 # [6727583.095786] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...117machine1 # [6727583.096615] machine1 systemd[1]: Starting SSH Host Keys Generation...118machine1 # [6727583.113626] machine1 network-addresses-eth1-start[166]: adding address 192.168.1.1/24... done119machine1 # [6727583.114332] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.120machine1 # [6727583.117222] machine1 network-addresses-eth1-start[166]: adding address 2001:db8:1::1/64... done121machine1 # [6727583.121305] machine1 systemd[1]: Finished Address configuration of eth1.122machine2 # [6727583.154168] machine2 systemd[1]: nscd.service: Deactivated successfully.123machine2 # [6727583.154311] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).124machine2 # [6727583.156457] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...125machine1 # [6727583.158376] machine1 systemd[1]: nscd.service: Deactivated successfully.126machine1 # [6727583.158480] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).127machine1 # [6727583.160361] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...128machine1 # [6727583.168614] machine1 systemd[1]: Finished Extra networking commands..129machine1 # [6727583.168907] machine1 systemd[1]: Reached target Network.130machine1 # [6727583.225683] machine1 nsncd[236]: Aug 25 20:10:09.278 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"131machine1 # [6727583.225806] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).132machine1 # [6727583.225864] machine1 systemd[1]: Reached target Host and Network Name Lookups.133machine1 # [6727583.225923] machine1 systemd[1]: Reached target User and Group Name Lookups.134machine1 # [6727583.227204] machine1 systemd[1]: Starting User Login Management...135machine1 # [6727583.228065] machine1 systemd[1]: Starting Permit User Sessions...136machine1 # [6727583.237483] machine1 systemd[1]: Finished Permit User Sessions.137machine1 # [6727583.238466] machine1 systemd[1]: Started Console Getty.138machine1 # [6727583.238506] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0139machine1 # [6727583.238529] machine1 systemd[1]: Reached target Login Prompts.140machine2 # [6727583.163505] machine2 systemd[1]: Finished Extra networking commands..141machine2 # [6727583.163678] machine2 systemd[1]: Reached target Network.142machine2 # [6727583.222119] machine2 nsncd[237]: Aug 25 20:10:09.275 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"143machine2 # [6727583.222192] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).144machine2 # [6727583.222252] machine2 systemd[1]: Reached target Host and Network Name Lookups.145machine2 # [6727583.222314] machine2 systemd[1]: Reached target User and Group Name Lookups.146machine2 # [6727583.223876] machine2 systemd[1]: Starting User Login Management...147machine2 # [6727583.225005] machine2 systemd[1]: Starting Permit User Sessions...148machine2 # [6727583.234400] machine2 systemd[1]: Finished Permit User Sessions.149machine2 # [6727583.235459] machine2 systemd[1]: Started Console Getty.150machine2 # [6727583.235508] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0151machine2 # [6727583.235527] machine2 systemd[1]: Reached target Login Prompts.152machine1 # [6727583.588177] machine1 systemd-logind[255]: New seat seat0.153machine1 # [6727583.588507] machine1 systemd[1]: Started User Login Management.154machine1 # [6727583.590244] machine1 systemd[1]: Starting D-Bus System Message Bus...155machine1 # [6727583.591609] machine1 systemd[1]: Starting linger-users.service...156machine2 # [6727583.588382] machine2 systemd-logind[255]: New seat seat0.157machine1 # [6727583.637680] machine1 systemd[1]: linger-users.service: Deactivated successfully.158machine2 # [6727583.588655] machine2 systemd[1]: Started User Login Management.159machine1 # [6727583.637758] machine1 systemd[1]: Finished linger-users.service.160machine2 # [6727583.590267] machine2 systemd[1]: Starting D-Bus System Message Bus...161machine1 # [6727583.805632] machine1 dbus-broker-launch[265]: Looking up NSS user entry for 'systemd-timesync'...162machine2 # [6727583.591611] machine2 systemd[1]: Starting linger-users.service...163machine1 # [6727583.806663] machine1 dbus-broker-launch[265]: NSS returned no entry for 'systemd-timesync'164machine2 # [6727583.637098] machine2 systemd[1]: linger-users.service: Deactivated successfully.165machine1 # [6727583.806663] machine1 dbus-broker-launch[265]: Invalid user-name in /nix/store/9km33hjpw8h8m70w8x61zbdvz7l0xz06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"166machine2 # [6727583.637255] machine2 systemd[1]: Finished linger-users.service.167machine1 # [6727583.807200] machine1 systemd[1]: Started D-Bus System Message Bus.168machine2 # [6727583.805940] machine2 dbus-broker-launch[265]: Looking up NSS user entry for 'systemd-timesync'...169machine2 # [6727583.806569] machine2 dbus-broker-launch[265]: NSS returned no entry for 'systemd-timesync'170machine1 # [6727583.814099] machine1 dbus-broker-launch[265]: Ready171machine2 # [6727583.806569] machine2 dbus-broker-launch[265]: Invalid user-name in /nix/store/9km33hjpw8h8m70w8x61zbdvz7l0xz06-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"172machine2 # [6727583.806967] machine2 systemd[1]: Started D-Bus System Message Bus.173machine2 # [6727583.814089] machine2 dbus-broker-launch[265]: Ready174machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Generating public/private rsa key pair.175machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key176machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub177machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: The key fingerprint is:178machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: SHA256:9k3sfFrN6ZrFFQ4wPYQ2bxESKn7866XSshcw1ZXvk4g root@machine2179machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: The key's randomart image is:180machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: +---[RSA 4096]----+181machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | =*oo..|182machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .=+= . |183machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | . .o o.o..|184machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | . oo . oo o|185machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .Soo = .oo|186machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | ....E ..=+|187machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | o.=.o++|188machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | o o+++ |189machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: | .*+.o.. |190machine2 # [6727584.787735] machine2 sshd-keygen-start[190]: +----[SHA256]-----+191machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Generating public/private ed25519 key pair.192machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key193machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub194machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: The key fingerprint is:195machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: SHA256:osYyeVYrONPXYXfh2+9ltWzNrYOg0N22gkT6QrpGSCo root@machine2196machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: The key's randomart image is:197machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: +--[ED25519 256]--+198machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | |199machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | |200machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | . |201machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | . . . . |202machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | o . o+S...o .|203machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: |E .=.o+=ooo.oo..=|204machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: |. B.Ooo+.o o.o.+*|205machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | Ooo. + . o o+.|206machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: | ... . . .oo|207machine2 # [6727584.802979] machine2 sshd-keygen-start[275]: +----[SHA256]-----+208machine2 # [6727584.804573] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.209machine2 # [6727584.804828] machine2 systemd[1]: Finished SSH Host Keys Generation.210machine2 # [6727584.805142] machine2 systemd[1]: sshd-keygen.service: Consumed 3.411s CPU time over 1.711s wall clock time.211machine2 # [6727584.807938] machine2 systemd[1]: Starting SSH Daemon...212machine2 # [6727584.824011] machine2 sshd[277]: Server listening on 0.0.0.0 port 22.213machine2 # [6727584.824040] machine2 sshd[277]: Server listening on :: port 22.214machine2 # [6727584.824202] machine2 systemd[1]: Started SSH Daemon.215machine2 # [6727584.824460] machine2 systemd[1]: Reached target Multi-User System.216machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Generating public/private rsa key pair.217machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key218machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub219machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: The key fingerprint is:220machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: SHA256:j95lJIumGsXXiL/lPtYXdIaffXQ3VetTvUk8M4VRSDQ root@machine1221machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: The key's randomart image is:222machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: +---[RSA 4096]----+223machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | oE==|224machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | +.=|225machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | O+|226machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . . o =.&|227machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | + S o .. X*|228machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . o + + ..=|229machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . = +.o ..|230machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | . + =oo. . |231machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: | ... oo+. . |232machine1 # [6727584.848421] machine1 sshd-keygen-start[188]: +----[SHA256]-----+233machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Generating public/private ed25519 key pair.234machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key235machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub236machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: The key fingerprint is:237machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: SHA256:liAT/6+tk00S5+HiJSWulgpxbP7C0AVuNaf6MXhTQLs root@machine1238machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: The key's randomart image is:239machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: +--[ED25519 256]--+240machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | ... |241machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o+.. |242machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .oo+= |243machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .ooo++.+ |244machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o++EoSB . |245machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .=+ =.=.= |246machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o.o B O. |247machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .o.= +o. |248machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: | .+. oo. |249machine1 # [6727584.863573] machine1 sshd-keygen-start[275]: +----[SHA256]-----+250machine1 # [6727584.864986] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.251machine1 # [6727584.865064] machine1 systemd[1]: Finished SSH Host Keys Generation.252machine1 # [6727584.866611] machine1 systemd[1]: Starting SSH Daemon...253machine1 # [6727584.882202] machine1 sshd[277]: Server listening on 0.0.0.0 port 22.254machine1 # [6727584.882228] machine1 sshd[277]: Server listening on :: port 22.255machine1 # [6727584.882375] machine1 systemd[1]: Started SSH Daemon.256machine1 # [6727584.882615] machine1 systemd[1]: Reached target Multi-User System.257machine2 # [6727585.340407] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.258machine2 # [6727585.342204] machine2 systemd[1]: Finished Save Transient machine-id to Disk.259machine2 # [6727585.342695] machine2 systemd[1]: Startup finished in 2.846s.260machine1 # [6727585.340098] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.261machine1 # [6727585.342072] machine1 systemd[1]: Finished Save Transient machine-id to Disk.262machine1 # [6727585.342582] machine1 systemd[1]: Startup finished in 2.846s.263machine1: (finished: must succeed: systemctl status sshd, in 3.66 seconds)264machine2: must succeed: systemctl status sshd265machine2: (finished: must succeed: systemctl status sshd, in 0.01 seconds)266machine1: waiting for unit sshd267machine1: (finished: waiting for unit sshd, in 0.01 seconds)268machine2: waiting for unit sshd269machine2: (finished: waiting for unit sshd, in 0.01 seconds)270machine1: must succeed: ip addr show eth1271machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)272machine2: must succeed: ip addr show eth1273machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)274machine1: must succeed: ping -c 1 machine2275machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)276(finished: run the VM test script, in 3.73 seconds)277test script finished in 4.13s278cleanup279kill NspawnMachine (pid 52)280kill NspawnMachine (pid 53)281Container machine1 terminated by signal KILL.282Container machine2 terminated by signal KILL.283(finished: cleanup, in 0.38 seconds)