container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #810
· raw
1build01: building 9qci6v2xcnjaqg2sb1jr9x7r66x1sbda-container-test-run-container.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)56Test will time out and terminate in 3600.0 seconds7run the VM test script8additionally exposed symbols:9 machine1, machine2,10 vlan1,11 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_ssh12start all VMs13machine1: systemd-nspawn running (pid 52)14machine2: systemd-nspawn running (pid 53)15machine1: Waiting for journal at /build/vm-state-machine1/var/log/journal...16machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal...17(finished: start all VMs, in 0.00 seconds)18machine1: must succeed: systemctl status sshd19nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE20nixos-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.21nixos-nspawn(machine2): TAP vde-tap1 not found; container will be isolated from VDE22nixos-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.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.24Note: 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.25░ Spawning container machine1 on /build/vm-state-machine1.26░ Spawning container machine2 on /build/vm-state-machine2.27machine1 # [2258269.093867] machine1 systemd-journald[57]: Journal started28machine1 # [2258269.093928] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/d232f7a8fc664240933db6e3980539f0) is 8M, max 2.5G, 2.4G free.29machine1 # [2258269.095103] machine1 systemd[1]: Finished Apply Kernel Variables.30machine1 # [2258269.105549] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.31machine1 # [2258269.117157] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...32machine1 # [2258269.117900] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...33machine1 # [2258269.128119] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/d232f7a8fc664240933db6e3980539f0 is 1.840ms for 6 entries.34machine1 # [2258269.128119] machine1 systemd-journald[57]: System Journal (/var/log/journal/d232f7a8fc664240933db6e3980539f0) is 8M, max 4G, 3.9G free.35machine1 # [2258269.134375] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.36machine1 # [2258269.134942] machine1 systemd[1]: Reached target Preparation for Local File Systems.37machine1 # [2258269.135047] machine1 systemd[1]: Reached target Local File Systems.38machine1 # [2258269.135856] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.39machine1 # [2258269.135909] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container40machine1 # [2258269.136708] machine1 systemd[1]: Starting Save Transient machine-id to Disk...41machine1 # [2258269.136744] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys42machine1 # [2258269.139368] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.43machine1 # [2258269.140542] machine1 systemd[1]: Starting Create System Files and Directories...44machine1 # [2258269.159536] machine1 systemd-tmpfiles[100]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted45machine1 # [2258269.159766] machine1 systemd-tmpfiles[100]: fchmod() of /var/log/journal failed: Operation not permitted46machine1 # [2258269.159929] machine1 systemd-tmpfiles[100]: fchmod() of /var/log/journal/d232f7a8fc664240933db6e3980539f0 failed: Operation not permitted47machine1 # [2258269.160207] machine1 systemd-tmpfiles[100]: fchmod() of /run/log/journal failed: Operation not permitted48machine2 # [2258269.094487] machine2 systemd-journald[57]: Journal started49machine2 # [2258269.094545] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/66a0206fb6ce40e3afbe68fccc32e159) is 8M, max 2.5G, 2.4G free.50machine2 # [2258269.097940] machine2 systemd[1]: Finished Apply Kernel Variables.51machine2 # [2258269.108699] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.52machine2 # [2258269.120684] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...53machine2 # [2258269.121299] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...54machine2 # [2258269.131724] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/66a0206fb6ce40e3afbe68fccc32e159 is 2.262ms for 6 entries.55machine2 # [2258269.131724] machine2 systemd-journald[57]: System Journal (/var/log/journal/66a0206fb6ce40e3afbe68fccc32e159) is 8M, max 4G, 3.9G free.56machine2 # [2258269.138259] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.57machine2 # [2258269.138853] machine2 systemd[1]: Reached target Preparation for Local File Systems.58machine2 # [2258269.138961] machine2 systemd[1]: Reached target Local File Systems.59machine2 # [2258269.139793] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.60machine2 # [2258269.139844] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container61machine2 # [2258269.140611] machine2 systemd[1]: Starting Save Transient machine-id to Disk...62machine2 # [2258269.140651] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys63machine2 # [2258269.148397] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.64machine2 # [2258269.149479] machine2 systemd[1]: Starting Create System Files and Directories...65machine2 # [2258269.165692] machine2 systemd-tmpfiles[104]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted66machine2 # [2258269.165879] machine2 systemd-tmpfiles[104]: fchmod() of /var/log/journal failed: Operation not permitted67machine2 # [2258269.166007] machine2 systemd-tmpfiles[104]: fchmod() of /var/log/journal/66a0206fb6ce40e3afbe68fccc32e159 failed: Operation not permitted68machine2 # [2258269.166196] machine2 systemd-tmpfiles[104]: fchmod() of /run/log/journal failed: Operation not permitted69machine2 # [2258269.167495] machine2 systemd[1]: Finished Create System Files and Directories.70machine2 # [2258269.168535] machine2 systemd[1]: Starting Rebuild Journal Catalog...71machine2 # [2258269.169242] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...72machine2 # [2258269.179717] machine2 systemd[1]: Finished Save Transient machine-id to Disk.73machine2 # [2258269.183306] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.74machine2 # [2258269.192410] machine2 systemd[1]: Finished Rebuild Journal Catalog.75machine2 # [2258269.193582] machine2 systemd[1]: Starting Update is Completed...76machine2 # [2258269.208673] machine2 systemd[1]: Finished Update is Completed.77machine2 # [2258269.208848] machine2 systemd[1]: Reached target System Initialization.78machine2 # [2258269.208939] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container79machine2 # [2258269.208974] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.80machine2 # [2258269.208991] machine2 systemd[1]: Reached target Timer Units.81machine2 # [2258269.209112] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.82machine2 # [2258269.209232] machine2 systemd[1]: Listening on Nix Daemon Socket.83machine2 # [2258269.210431] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).84machine2 # [2258269.211487] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).85machine2 # [2258269.211598] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.86machine2 # [2258269.211621] machine2 systemd[1]: Reached target Socket Units.87machine2 # [2258269.211671] machine2 systemd[1]: Reached target Basic System.88machine2 # [2258269.212806] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...89machine2 # [2258269.213627] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...90machine2 # [2258269.214362] machine2 systemd[1]: Starting SSH Host Keys Generation...91machine2 # [2258269.235815] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.92machine2 # [2258269.265993] machine2 systemd[1]: Finished Firewall.93machine2 # [2258269.266174] machine2 systemd[1]: Reached target Preparation for Network.94machine2 # [2258269.267139] machine2 systemd[1]: Starting Address configuration of eth1...95machine2 # [2258269.268160] machine2 systemd[1]: Starting Extra networking commands....96machine2 # [2258269.286046] machine2 network-addresses-eth1-start[182]: adding address 192.168.1.2/24... done97machine2 # [2258269.289287] machine2 network-addresses-eth1-start[182]: adding address 2001:db8:1::2/64... done98machine2 # [2258269.294015] machine2 systemd[1]: Finished Address configuration of eth1.99machine2 # [2258269.323939] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).100machine2 # [2258269.324271] machine2 nsncd[144]: Sep 30 10:44:49.309 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"101machine2 # [2258269.324078] machine2 systemd[1]: Reached target Host and Network Name Lookups.102machine2 # [2258269.324191] machine2 systemd[1]: Reached target User and Group Name Lookups.103machine2 # [2258269.326079] machine2 systemd[1]: Starting User Login Management...104machine2 # [2258269.335330] machine2 systemd[1]: Stopped target Host and Network Name Lookups.105machine2 # [2258269.335399] machine2 systemd[1]: Stopping Host and Network Name Lookups...106machine2 # [2258269.335460] machine2 systemd[1]: Stopped target User and Group Name Lookups.107machine2 # [2258269.335492] machine2 systemd[1]: Stopping User and Group Name Lookups...108machine2 # [2258269.335664] machine2 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...109machine2 # [2258269.339507] machine2 systemd[1]: nscd.service: Deactivated successfully.110machine2 # [2258269.339671] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).111machine2 # [2258269.342262] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...112machine2 # [2258269.350069] machine2 systemd[1]: Finished Extra networking commands..113machine2 # [2258269.350265] machine2 systemd[1]: Reached target Network.114machine1 # [2258269.161652] machine1 systemd[1]: Finished Create System Files and Directories.115machine1 # [2258269.162701] machine1 systemd[1]: Starting Rebuild Journal Catalog...116machine1 # [2258269.163458] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...117machine1 # [2258269.178290] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.118machine1 # [2258269.179757] machine1 systemd[1]: Finished Save Transient machine-id to Disk.119machine1 # [2258269.183489] machine1 systemd[1]: Finished Rebuild Journal Catalog.120machine1 # [2258269.184859] machine1 systemd[1]: Starting Update is Completed...121machine1 # [2258269.196927] machine1 systemd[1]: Finished Update is Completed.122machine1 # [2258269.197097] machine1 systemd[1]: Reached target System Initialization.123machine1 # [2258269.197193] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container124machine1 # [2258269.197231] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.125machine1 # [2258269.197251] machine1 systemd[1]: Reached target Timer Units.126machine1 # [2258269.197359] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.127machine1 # [2258269.197479] machine1 systemd[1]: Listening on Nix Daemon Socket.128machine1 # [2258269.198689] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).129machine1 # [2258269.199712] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).130machine1 # [2258269.199818] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.131machine1 # [2258269.199843] machine1 systemd[1]: Reached target Socket Units.132machine1 # [2258269.199890] machine1 systemd[1]: Reached target Basic System.133machine1 # [2258269.200995] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...134machine1 # [2258269.201828] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...135machine1 # [2258269.202723] machine1 systemd[1]: Starting SSH Host Keys Generation...136machine1 # [2258269.222483] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.137machine1 # [2258269.268666] machine1 systemd[1]: Finished Firewall.138machine1 # [2258269.268869] machine1 systemd[1]: Reached target Preparation for Network.139machine1 # [2258269.270065] machine1 systemd[1]: Starting Address configuration of eth1...140machine1 # [2258269.271028] machine1 systemd[1]: Starting Extra networking commands....141machine1 # [2258269.288594] machine1 network-addresses-eth1-start[182]: adding address 192.168.1.1/24... done142machine1 # [2258269.291345] machine1 network-addresses-eth1-start[182]: adding address 2001:db8:1::1/64... done143machine1 # [2258269.296128] machine1 systemd[1]: Finished Address configuration of eth1.144machine1 # [2258269.312447] machine1 nsncd[137]: Sep 30 10:44:49.298 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"145machine1 # [2258269.312466] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).146machine1 # [2258269.312544] machine1 systemd[1]: Reached target Host and Network Name Lookups.147machine1 # [2258269.312625] machine1 systemd[1]: Reached target User and Group Name Lookups.148machine1 # [2258269.314164] machine1 systemd[1]: Starting User Login Management...149machine1 # [2258269.332623] machine1 systemd[1]: Stopped target Host and Network Name Lookups.150machine1 # [2258269.332695] machine1 systemd[1]: Stopping Host and Network Name Lookups...151machine1 # [2258269.332756] machine1 systemd[1]: Stopped target User and Group Name Lookups.152machine1 # [2258269.332791] machine1 systemd[1]: Stopping User and Group Name Lookups...153machine1 # [2258269.332989] machine1 systemd[1]: Stopping Name Service Cache Daemon (nsncd)...154machine1 # [2258269.336881] machine1 systemd[1]: nscd.service: Deactivated successfully.155machine1 # [2258269.337075] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).156machine1 # [2258269.339635] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...157machine1 # [2258269.348719] machine1 systemd[1]: Finished Extra networking commands..158machine1 # [2258269.348876] machine1 systemd[1]: Reached target Network.159machine1 # [2258269.458246] machine1 nsncd[257]: Sep 30 10:44:49.443 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"160machine1 # [2258269.458268] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).161machine1 # [2258269.458374] machine1 systemd[1]: Reached target Host and Network Name Lookups.162machine1 # [2258269.458481] machine1 systemd[1]: Reached target User and Group Name Lookups.163machine1 # [2258269.460279] machine1 systemd[1]: Starting Permit User Sessions...164machine1 # [2258269.520125] machine1 systemd[1]: Finished Permit User Sessions.165machine1 # [2258269.521918] machine1 systemd[1]: Started Console Getty.166machine1 # [2258269.521992] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0167machine1 # [2258269.522031] machine1 systemd[1]: Reached target Login Prompts.168machine2 # [2258269.466558] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).169machine2 # [2258269.468074] machine2 nsncd[258]: Sep 30 10:44:49.452 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"170machine2 # [2258269.466668] machine2 systemd[1]: Reached target Host and Network Name Lookups.171machine2 # [2258269.466777] machine2 systemd[1]: Reached target User and Group Name Lookups.172machine2 # [2258269.512467] machine2 systemd[1]: Starting Permit User Sessions...173machine2 # [2258269.529860] machine2 systemd[1]: Finished Permit User Sessions.174machine2 # [2258269.531427] machine2 systemd[1]: Started Console Getty.175machine2 # [2258269.531507] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0176machine2 # [2258269.531550] machine2 systemd[1]: Reached target Login Prompts.177machine2 # [2258269.987087] machine2 systemd-logind[241]: New seat seat0.178machine2 # [2258270.008442] machine2 systemd[1]: Starting D-Bus System Message Bus...179machine2 # [2258270.008525] machine2 systemd[1]: Started User Login Management.180machine2 # [2258270.009546] machine2 systemd[1]: Starting linger-users.service...181machine2 # [2258270.029444] machine2 systemd[1]: linger-users.service: Deactivated successfully.182machine2 # [2258270.029544] machine2 systemd[1]: Finished linger-users.service.183machine2 # [2258270.088295] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.184machine1 # [2258269.977507] machine1 systemd-logind[231]: New seat seat0.185machine1 # [2258269.977907] machine1 systemd[1]: Started User Login Management.186machine1 # [2258269.979555] machine1 systemd[1]: Starting D-Bus System Message Bus...187machine1 # [2258269.980884] machine1 systemd[1]: Starting linger-users.service...188machine1 # [2258270.018341] machine1 systemd[1]: linger-users.service: Deactivated successfully.189machine1 # [2258270.018616] machine1 systemd[1]: Finished linger-users.service.190machine1 # [2258270.100640] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.191machine1 # [2258270.258317] machine1 dbus-broker-launch[279]: Looking up NSS user entry for 'systemd-timesync'...192machine1 # [2258270.259516] machine1 dbus-broker-launch[279]: NSS returned no entry for 'systemd-timesync'193machine1 # [2258270.259516] machine1 dbus-broker-launch[279]: Invalid user-name in /nix/store/j6f2hp617igkg1gczslizh76dkv4pvf2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"194machine1 # [2258270.259959] machine1 systemd[1]: Started D-Bus System Message Bus.195machine1 # [2258270.267766] machine1 dbus-broker-launch[279]: Ready196machine2 # [2258270.246391] machine2 dbus-broker-launch[279]: Looking up NSS user entry for 'systemd-timesync'...197machine2 # [2258270.247416] machine2 dbus-broker-launch[279]: NSS returned no entry for 'systemd-timesync'198machine2 # [2258270.247416] machine2 dbus-broker-launch[279]: Invalid user-name in /nix/store/j6f2hp617igkg1gczslizh76dkv4pvf2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"199machine2 # [2258270.247847] machine2 systemd[1]: Started D-Bus System Message Bus.200machine2 # [2258270.256336] machine2 dbus-broker-launch[279]: Ready201machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: Generating public/private rsa key pair.202machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key203machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub204machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: The key fingerprint is:205machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: SHA256:wzK7ir3OanJ1oy6GZ0wOWKbJae/zOBJTAyxYYSLX8po root@machine2206machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: The key's randomart image is:207machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: +---[RSA 4096]----+208machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |=.=o |209machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |+*. . |210machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |. .o |211machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: | oo. . |212machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |o=oo. o S |213machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |=*E . o+ . |214machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |.*+. o.. |215machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: |o.XBo . |216machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: | B=B@+. |217machine2 # [2258270.967927] machine2 sshd-keygen-start[163]: +----[SHA256]-----+218machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: Generating public/private ed25519 key pair.219machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key220machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub221machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: The key fingerprint is:222machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: SHA256:O//5BpJ/hfyuGKvz44PTU+uRpLjnBhDlA4WHeAIv0nY root@machine2223machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: The key's randomart image is:224machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: +--[ED25519 256]--+225machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | .. ..=o |226machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | . .o =o. |227machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | . + Eo oo |228machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | o o . . |229machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | S. . ... |230machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | .+..o+..|231machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | o .*ooo+ |232machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | o+.O=+..|233machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: | +@OO+o.|234machine2 # [2258270.985752] machine2 sshd-keygen-start[289]: +----[SHA256]-----+235machine2 # [2258270.987843] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.236machine2 # [2258270.988195] machine2 systemd[1]: Finished SSH Host Keys Generation.237machine2 # [2258270.988559] machine2 systemd[1]: sshd-keygen.service: Consumed 3.551s CPU time over 1.773s wall clock time.238machine2 # [2258270.990436] machine2 systemd[1]: Starting SSH Daemon...239machine2 # [2258271.055354] machine2 sshd[291]: Server listening on 0.0.0.0 port 22.240machine2 # [2258271.055624] machine2 sshd[291]: Server listening on :: port 22.241machine2 # [2258271.055802] machine2 systemd[1]: Started SSH Daemon.242machine2 # [2258271.056051] machine2 systemd[1]: Reached target Multi-User System.243machine2 # [2258271.056365] machine2 systemd[1]: Startup finished in 2.412s.244machine1: (finished: must succeed: systemctl status sshd, in 4.66 seconds)245machine2: must succeed: systemctl status sshd246machine2: (finished: must succeed: systemctl status sshd, in 0.02 seconds)247machine1: waiting for unit sshd248machine1: (finished: waiting for unit sshd, in 0.02 seconds)249machine2: waiting for unit sshd250machine2: (finished: waiting for unit sshd, in 0.01 seconds)251machine1: must succeed: ip addr show eth1252machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: Generating public/private rsa key pair.253machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key254machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub255machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: The key fingerprint is:256machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: SHA256:r7o9+Wk79M+XV5v06dk3PTMQRFFyp0x3zw1hDiUZZPo root@machine1257machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: The key's randomart image is:258machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: +---[RSA 4096]----+259machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | .BBO++|260machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | o.Oo==|261machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | . . + +|262machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | . . |263machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | S E . |264machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | .. . ..|265machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | o.. o O|266machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | .o.o... XO|267machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: | ooo++o .++O|268machine1 # [2258272.556936] machine1 sshd-keygen-start[158]: +----[SHA256]-----+269machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: Generating public/private ed25519 key pair.270machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key271machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub272machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: The key fingerprint is:273machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: SHA256:LVwyYy/QEL6HL74Vhka7Dz6NlUEPcH9LR1MSl4uVF5U root@machine1274machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: The key's randomart image is:275machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: +--[ED25519 256]--+276machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | +o. =+X|277machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | . +o. . E.|278machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | +.*oo o + o|279machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | . O.B.o + . |280machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | * Soo . |281machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | . =o+ |282machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | ++o |283machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | oo=. |284machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: | +o. |285machine1 # [2258272.575268] machine1 sshd-keygen-start[289]: +----[SHA256]-----+286machine1 # [2258272.577351] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.287machine1 # [2258272.577511] machine1 systemd[1]: Finished SSH Host Keys Generation.288machine1 # [2258272.579742] machine1 systemd[1]: Starting SSH Daemon...289machine1 # [2258272.659480] machine1 sshd[291]: Server listening on 0.0.0.0 port 22.290machine1 # [2258272.659521] machine1 sshd[291]: Server listening on :: port 22.291machine1 # [2258272.659683] machine1 systemd[1]: Started SSH Daemon.292machine1 # [2258272.660064] machine1 systemd[1]: Reached target Multi-User System.293machine1 # [2258272.660386] machine1 systemd[1]: Startup finished in 4.026s.294machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)295machine2: must succeed: ip addr show eth1296machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)297machine1: must succeed: ping -c 1 machine2298machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)299(finished: run the VM test script, in 4.75 seconds)300test script finished in 4.78s301cleanup302kill NspawnMachine (pid 52)303kill NspawnMachine (pid 53)304Container machine1 terminated by signal KILL.305Container machine2 terminated by signal KILL.306(finished: cleanup, in 0.38 seconds)