container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #1043
· raw
1build01: building izv18shjy76bfvh51z48xvpgwx869im0-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)5Initializing machine ID from random generator.6Test 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 VMs13machine2: systemd-nspawn running (pid 53)14machine1: systemd-nspawn running (pid 52)15machine2: Waiting for journal at /build/vm-state-machine2/var/log/journal...16machine1: Waiting for journal at /build/vm-state-machine1/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 machine2 on /build/vm-state-machine2.26░ Spawning container machine1 on /build/vm-state-machine1.27machine2 # [312585.216319] machine2 systemd-journald[58]: Journal started28machine2 # [312585.216376] machine2 systemd-journald[58]: Runtime Journal (/run/log/journal/9736f1eedbcf48f9b00f9ad374859af3) is 8M, max 2.5G, 2.4G free.29machine2 # [312585.229254] machine2 systemd[1]: Finished Apply Kernel Variables.30machine2 # [312585.243017] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.31machine2 # [312585.255748] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...32machine2 # [312585.256575] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...33machine2 # [312585.265922] machine2 systemd-journald[58]: Time spent on flushing to /var/log/journal/9736f1eedbcf48f9b00f9ad374859af3 is 1.733ms for 6 entries.34machine2 # [312585.265922] machine2 systemd-journald[58]: System Journal (/var/log/journal/9736f1eedbcf48f9b00f9ad374859af3) is 8M, max 4G, 3.9G free.35machine2 # [312585.274700] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.36machine2 # [312585.275394] machine2 systemd[1]: Reached target Preparation for Local File Systems.37machine2 # [312585.275510] machine2 systemd[1]: Reached target Local File Systems.38machine2 # [312585.276286] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.39machine2 # [312585.276344] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container40machine2 # [312585.277208] machine2 systemd[1]: Starting Save Transient machine-id to Disk...41machine2 # [312585.277247] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys42machine2 # [312585.300900] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.43machine2 # [312585.302536] machine2 systemd[1]: Starting Create System Files and Directories...44machine2 # [312585.331534] machine2 systemd-tmpfiles[125]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted45machine2 # [312585.331832] machine2 systemd-tmpfiles[125]: fchmod() of /var/log/journal failed: Operation not permitted46machine2 # [312585.332250] machine2 systemd-tmpfiles[125]: fchmod() of /var/log/journal/9736f1eedbcf48f9b00f9ad374859af3 failed: Operation not permitted47machine2 # [312585.332786] machine2 systemd-tmpfiles[125]: fchmod() of /run/log/journal failed: Operation not permitted48machine2 # [312585.334625] machine2 systemd[1]: Finished Create System Files and Directories.49machine2 # [312585.335703] machine2 systemd[1]: Starting Rebuild Journal Catalog...50machine2 # [312585.336552] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...51machine2 # [312585.348584] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.52machine2 # [312585.355812] machine2 systemd[1]: Finished Rebuild Journal Catalog.53machine2 # [312585.357013] machine2 systemd[1]: Starting Update is Completed...54machine2 # [312585.366302] machine2 systemd[1]: Finished Firewall.55machine1 # [312585.216500] machine1 systemd-journald[58]: Journal started56machine1 # [312585.216552] machine1 systemd-journald[58]: Runtime Journal (/run/log/journal/a2fdeeedc092474eaec83f4cedb416b1) is 8M, max 2.5G, 2.4G free.57machine1 # [312585.229282] machine1 systemd[1]: Finished Apply Kernel Variables.58machine1 # [312585.242954] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.59machine1 # [312585.255825] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...60machine1 # [312585.256502] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...61machine1 # [312585.265863] machine1 systemd-journald[58]: Time spent on flushing to /var/log/journal/a2fdeeedc092474eaec83f4cedb416b1 is 1.560ms for 6 entries.62machine1 # [312585.265863] machine1 systemd-journald[58]: System Journal (/var/log/journal/a2fdeeedc092474eaec83f4cedb416b1) is 8M, max 4G, 3.9G free.63machine1 # [312585.273097] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.64machine1 # [312585.273756] machine1 systemd[1]: Reached target Preparation for Local File Systems.65machine1 # [312585.273870] machine1 systemd[1]: Reached target Local File Systems.66machine1 # [312585.274588] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.67machine1 # [312585.274644] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container68machine1 # [312585.275510] machine1 systemd[1]: Starting Save Transient machine-id to Disk...69machine1 # [312585.275546] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys70machine1 # [312585.299834] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.71machine1 # [312585.301483] machine1 systemd[1]: Starting Create System Files and Directories...72machine1 # [312585.316917] machine1 systemd-tmpfiles[123]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted73machine1 # [312585.317074] machine1 systemd-tmpfiles[123]: fchmod() of /var/log/journal failed: Operation not permitted74machine1 # [312585.317177] machine1 systemd-tmpfiles[123]: fchmod() of /var/log/journal/a2fdeeedc092474eaec83f4cedb416b1 failed: Operation not permitted75machine1 # [312585.317331] machine1 systemd-tmpfiles[123]: fchmod() of /run/log/journal failed: Operation not permitted76machine1 # [312585.318774] machine1 systemd[1]: Finished Create System Files and Directories.77machine1 # [312585.319921] machine1 systemd[1]: Starting Rebuild Journal Catalog...78machine1 # [312585.320744] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...79machine1 # [312585.333031] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.80machine1 # [312585.340185] machine1 systemd[1]: Finished Rebuild Journal Catalog.81machine1 # [312585.341308] machine1 systemd[1]: Starting Update is Completed...82machine1 # [312585.352183] machine1 systemd[1]: Finished Update is Completed.83machine1 # [312585.352361] machine1 systemd[1]: Reached target System Initialization.84machine1 # [312585.352449] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container85machine1 # [312585.352485] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.86machine1 # [312585.352507] machine1 systemd[1]: Reached target Timer Units.87machine1 # [312585.352618] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.88machine1 # [312585.352730] machine1 systemd[1]: Listening on Nix Daemon Socket.89machine1 # [312585.353552] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).90machine1 # [312585.354149] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).91machine1 # [312585.354244] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.92machine1 # [312585.354268] machine1 systemd[1]: Reached target Socket Units.93machine1 # [312585.354306] machine1 systemd[1]: Reached target Basic System.94machine1 # [312585.355464] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...95machine1 # [312585.357970] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...96machine1 # [312585.358799] machine1 systemd[1]: Starting SSH Host Keys Generation...97machine1 # [312585.369202] machine1 systemd[1]: Finished Firewall.98machine1 # [312585.369373] machine1 systemd[1]: Reached target Preparation for Network.99machine1 # [312585.370330] machine1 systemd[1]: Starting Address configuration of eth1...100machine1 # [312585.371212] machine1 systemd[1]: Starting Extra networking commands....101machine1 # [312585.375378] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.102machine1 # [312585.394482] machine1 network-addresses-eth1-start[176]: adding address 192.168.1.1/24... done103machine1 # [312585.397070] machine1 network-addresses-eth1-start[176]: adding address 2001:db8:1::1/64... done104machine1 # [312585.401133] machine1 systemd[1]: Finished Address configuration of eth1.105machine1 # [312585.441411] machine1 systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available106machine1 # [312585.441492] machine1 systemd[1]: nscd.service: Deactivated successfully.107machine1 # [312585.441586] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).108machine1 # [312585.442972] machine1 systemd[1]: Finished Extra networking commands..109machine1 # [312585.443665] machine1 systemd[1]: Reached target Network.110machine1 # [312585.444772] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...111machine1 # [312585.446776] machine1 systemd[1]: Finished Save Transient machine-id to Disk.112machine2 # [312585.366620] machine2 systemd[1]: Finished Update is Completed.113machine2 # [312585.367146] machine2 systemd[1]: Reached target Preparation for Network.114machine2 # [312585.367246] machine2 systemd[1]: Reached target System Initialization.115machine2 # [312585.367309] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container116machine2 # [312585.367345] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.117machine2 # [312585.367363] machine2 systemd[1]: Reached target Timer Units.118machine2 # [312585.367506] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.119machine2 # [312585.367631] machine2 systemd[1]: Listening on Nix Daemon Socket.120machine2 # [312585.368534] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).121machine2 # [312585.369158] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).122machine2 # [312585.369259] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.123machine2 # [312585.369278] machine2 systemd[1]: Reached target Socket Units.124machine2 # [312585.369322] machine2 systemd[1]: Reached target Basic System.125machine2 # [312585.370353] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...126machine2 # [312585.371143] machine2 systemd[1]: Starting Address configuration of eth1...127machine2 # [312585.371986] machine2 systemd[1]: Starting Extra networking commands....128machine2 # [312585.373021] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...129machine2 # [312585.373854] machine2 systemd[1]: Starting SSH Host Keys Generation...130machine2 # [312585.391435] machine2 network-addresses-eth1-start[170]: adding address 192.168.1.2/24... done131machine2 # [312585.392043] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.132machine2 # [312585.394586] machine2 network-addresses-eth1-start[170]: adding address 2001:db8:1::2/64... done133machine2 # [312585.398115] machine2 systemd[1]: Finished Address configuration of eth1.134machine2 # [312585.441236] machine2 systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available135machine2 # [312585.441282] machine2 systemd[1]: nscd.service: Deactivated successfully.136machine2 # [312585.441515] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).137machine2 # [312585.443828] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...138machine2 # [312585.444145] machine2 systemd[1]: Finished Extra networking commands..139machine2 # [312585.444770] machine2 systemd[1]: Reached target Network.140machine2 # [312585.446774] machine2 systemd[1]: Finished Save Transient machine-id to Disk.141machine2 # [312585.591814] machine2 nsncd[246]: Oct 20 00:13:10.563 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"142machine2 # [312585.591857] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).143machine2 # [312585.591957] machine2 systemd[1]: Reached target Host and Network Name Lookups.144machine2 # [312585.592063] machine2 systemd[1]: Reached target User and Group Name Lookups.145machine2 # [312585.593648] machine2 systemd[1]: Starting User Login Management...146machine2 # [312585.594449] machine2 systemd[1]: Starting Permit User Sessions...147machine2 # [312585.607770] machine2 systemd[1]: Finished Permit User Sessions.148machine2 # [312585.608894] machine2 systemd[1]: Started Console Getty.149machine2 # [312585.608943] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0150machine2 # [312585.608960] machine2 systemd[1]: Reached target Login Prompts.151machine1 # [312585.592171] machine1 nsncd[247]: Oct 20 00:13:10.563 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"152machine1 # [312585.592218] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).153machine1 # [312585.592296] machine1 systemd[1]: Reached target Host and Network Name Lookups.154machine1 # [312585.592395] machine1 systemd[1]: Reached target User and Group Name Lookups.155machine1 # [312585.593798] machine1 systemd[1]: Starting User Login Management...156machine1 # [312585.594515] machine1 systemd[1]: Starting Permit User Sessions...157machine1 # [312585.605270] machine1 systemd[1]: Finished Permit User Sessions.158machine1 # [312585.606406] machine1 systemd[1]: Started Console Getty.159machine1 # [312585.606470] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0160machine1 # [312585.606492] machine1 systemd[1]: Reached target Login Prompts.161machine1 # [312586.212298] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.162machine1 # [312586.458594] machine1 systemd-logind[260]: New seat seat0.163machine1 # [312586.459510] machine1 systemd[1]: Starting D-Bus System Message Bus...164machine1 # [312586.459714] machine1 systemd[1]: Started User Login Management.165machine1 # [312586.460525] machine1 systemd[1]: Starting linger-users.service...166machine2 # [312586.211731] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.167machine1 # [312586.472583] machine1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available168machine1 # [312586.472641] machine1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available169machine2 # [312586.466008] machine2 systemd-logind[260]: New seat seat0.170machine1 # [312586.472677] machine1 systemd[1]: linger-users.service: Deactivated successfully.171machine2 # [312586.466419] machine2 systemd[1]: Started User Login Management.172machine1 # [312586.472853] machine1 systemd[1]: Finished linger-users.service.173machine2 # [312586.467866] machine2 systemd[1]: Starting D-Bus System Message Bus...174machine2 # [312586.469017] machine2 systemd[1]: Starting linger-users.service...175machine2 # [312586.481010] machine2 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available176machine2 # [312586.481029] machine2 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available177machine2 # [312586.481056] machine2 systemd[1]: linger-users.service: Deactivated successfully.178machine2 # [312586.481141] machine2 systemd[1]: Finished linger-users.service.179machine2 # [312586.724368] machine2 dbus-broker-launch[270]: Looking up NSS user entry for 'systemd-timesync'...180machine2 # [312586.725163] machine2 dbus-broker-launch[270]: NSS returned no entry for 'systemd-timesync'181machine2 # [312586.725217] machine2 dbus-broker-launch[270]: Invalid user-name in /nix/store/v6hhrnmnply5krh15hyd02gbjfxb76a1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"182machine2 # [312586.725761] machine2 systemd[1]: Started D-Bus System Message Bus.183machine2 # [312586.732391] machine2 dbus-broker-launch[270]: Ready184machine1 # [312586.724212] machine1 dbus-broker-launch[270]: Looking up NSS user entry for 'systemd-timesync'...185machine1 # [312586.725526] machine1 dbus-broker-launch[270]: NSS returned no entry for 'systemd-timesync'186machine1 # [312586.725526] machine1 dbus-broker-launch[270]: Invalid user-name in /nix/store/v6hhrnmnply5krh15hyd02gbjfxb76a1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"187machine1 # [312586.726173] machine1 systemd[1]: Started D-Bus System Message Bus.188machine1 # [312586.733299] machine1 dbus-broker-launch[270]: Ready189machine2 # [312586.989288] machine2 sshd-keygen-start[194]: Generating public/private rsa key pair.190machine2 # [312586.989288] machine2 sshd-keygen-start[194]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key191machine2 # [312586.989288] machine2 sshd-keygen-start[194]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub192machine2 # [312586.989288] machine2 sshd-keygen-start[194]: The key fingerprint is:193machine2 # [312586.989288] machine2 sshd-keygen-start[194]: SHA256:zZMYpkNKJqx95c1PY089/P3nSN5mNfiq27qJsA1e4PU root@machine2194machine2 # [312586.989288] machine2 sshd-keygen-start[194]: The key's randomart image is:195machine2 # [312586.989288] machine2 sshd-keygen-start[194]: +---[RSA 4096]----+196machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | |197machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | . |198machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | o o o o |199machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | o + = = = . o |200machine2 # [312586.989288] machine2 sshd-keygen-start[194]: |. . o +.S.O . = |201machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | . ..o+.= . +o|202machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | + ..E. o =|203machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | . * . oo +=|204machine2 # [312586.989288] machine2 sshd-keygen-start[194]: | o o *=o++=|205machine2 # [312586.989288] machine2 sshd-keygen-start[194]: +----[SHA256]-----+206machine2 # [312587.005069] machine2 sshd-keygen-start[280]: Generating public/private ed25519 key pair.207machine2 # [312587.005069] machine2 sshd-keygen-start[280]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key208machine2 # [312587.005069] machine2 sshd-keygen-start[280]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub209machine2 # [312587.005069] machine2 sshd-keygen-start[280]: The key fingerprint is:210machine2 # [312587.005069] machine2 sshd-keygen-start[280]: SHA256:K7V0l8XQSVcjx7zAgaFkdxrQ/aS8kGyLWZWYq72w0aU root@machine2211machine2 # [312587.005069] machine2 sshd-keygen-start[280]: The key's randomart image is:212machine2 # [312587.005069] machine2 sshd-keygen-start[280]: +--[ED25519 256]--+213machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | +o+O**++|214machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | o o=+O==.|215machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | ...= B .|216machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | B * o |217machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | S X B . |218machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | o X E . |219machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | . o + . |220machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | . . . |221machine2 # [312587.005069] machine2 sshd-keygen-start[280]: | |222machine2 # [312587.005069] machine2 sshd-keygen-start[280]: +----[SHA256]-----+223machine2 # [312587.007235] machine2 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available224machine2 # [312587.007355] machine2 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available225machine2 # [312587.007420] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.226machine2 # [312587.007776] machine2 systemd[1]: Finished SSH Host Keys Generation.227machine2 # [312587.008186] machine2 systemd[1]: sshd-keygen.service: Consumed 3.275s CPU time over 1.633s wall clock time.228machine2 # [312587.010341] machine2 systemd[1]: Starting SSH Daemon...229machine2 # [312587.074930] machine2 sshd[282]: Server listening on 0.0.0.0 port 22.230machine2 # [312587.074969] machine2 sshd[282]: Server listening on :: port 22.231machine2 # [312587.075494] machine2 systemd[1]: Started SSH Daemon.232machine2 # [312587.075840] machine2 systemd[1]: Reached target Multi-User System.233machine2 # [312587.076204] machine2 systemd[1]: Startup finished in 2.255s.234machine1: (finished: must succeed: systemctl status sshd, in 5.16 seconds)235machine2: must succeed: systemctl status sshd236machine2: (finished: must succeed: systemctl status sshd, in 0.02 seconds)237machine1: waiting for unit sshd238machine1: (finished: waiting for unit sshd, in 0.01 seconds)239machine2: waiting for unit sshd240machine2: (finished: waiting for unit sshd, in 0.01 seconds)241machine1: must succeed: ip addr show eth1242machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)243machine2: must succeed: ip addr show eth1244machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)245machine1: must succeed: ping -c 1 machine2246machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)247(finished: run the VM test script, in 5.24 seconds)248machine1 # [312589.389878] machine1 sshd-keygen-start[183]: Generating public/private rsa key pair.249machine1 # [312589.389878] machine1 sshd-keygen-start[183]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key250machine1 # [312589.389878] machine1 sshd-keygen-start[183]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub251machine1 # [312589.389878] machine1 sshd-keygen-start[183]: The key fingerprint is:252machine1 # [312589.389878] machine1 sshd-keygen-start[183]: SHA256:dN1uy9lYiR1BTypVhQ3SEb++lKOsJt2+inOk5eBKE0E root@machine1253machine1 # [312589.389878] machine1 sshd-keygen-start[183]: The key's randomart image is:254machine1 # [312589.389878] machine1 sshd-keygen-start[183]: +---[RSA 4096]----+255machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | E ..*X=|256machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | . . +o++|257machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | .. . o o.o|258machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | ... oo +|259machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | .S .o+.|260machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | .. o o.*.|261machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | o. B . ==.|262machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | . .=.=..o o|263machine1 # [312589.389878] machine1 sshd-keygen-start[183]: | ...=o+=.. |264machine1 # [312589.389878] machine1 sshd-keygen-start[183]: +----[SHA256]-----+265machine1 # [312589.405975] machine1 sshd-keygen-start[280]: Generating public/private ed25519 key pair.266machine1 # [312589.405975] machine1 sshd-keygen-start[280]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key267machine1 # [312589.405975] machine1 sshd-keygen-start[280]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub268machine1 # [312589.405975] machine1 sshd-keygen-start[280]: The key fingerprint is:269machine1 # [312589.405975] machine1 sshd-keygen-start[280]: SHA256:WzTPfgtGT62XZ7irZZfo3x124npTBwlUcgEL4pWbaVE root@machine1270machine1 # [312589.405975] machine1 sshd-keygen-start[280]: The key's randomart image is:271machine1 # [312589.405975] machine1 sshd-keygen-start[280]: +--[ED25519 256]--+272machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | . o+Eo+. |273machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | . oo..+ |274machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | . o=.. . |275machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | .=+ o. |276machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | S.. + ...|277machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | o o o.o=|278machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | . +.O*B|279machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | ..*+B*|280machine1 # [312589.405975] machine1 sshd-keygen-start[280]: | o=*+o|281machine1 # [312589.405975] machine1 sshd-keygen-start[280]: +----[SHA256]-----+282machine1 # [312589.407426] machine1 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available283machine1 # [312589.407452] machine1 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available284machine1 # [312589.407473] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.285machine1 # [312589.407572] machine1 systemd[1]: Finished SSH Host Keys Generation.286machine1 # [312589.409047] machine1 systemd[1]: Starting SSH Daemon...287machine1 # [312589.469992] machine1 sshd[282]: Server listening on 0.0.0.0 port 22.288machine1 # [312589.470015] machine1 sshd[282]: Server listening on :: port 22.289machine1 # [312589.470203] machine1 systemd[1]: Started SSH Daemon.290machine1 # [312589.470410] machine1 systemd[1]: Reached target Multi-User System.291machine1 # [312589.470621] machine1 systemd[1]: Startup finished in 4.653s.292test script finished in 5.50s293cleanup294kill NspawnMachine (pid 52)295kill NspawnMachine (pid 53)296Container machine1 terminated by signal KILL.297Container machine2 terminated by signal KILL.298(finished: cleanup, in 0.38 seconds)