container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #775
· raw
1build01: building lww0am9gx2vn1vy41dsmqn5lpm9279ld-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.24░ Spawning container machine1 on /build/vm-state-machine1.25Note: 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.26░ Spawning container machine2 on /build/vm-state-machine2.27machine1 # [1874276.202526] machine1 systemd-journald[57]: Journal started28machine2 # [1874276.194548] machine2 systemd-journald[57]: Journal started29machine1 # [1874276.202581] machine1 systemd-journald[57]: Runtime Journal (/run/log/journal/51268db163cd4604833108c2934c98cd) is 8M, max 2.5G, 2.4G free.30machine2 # [1874276.194605] machine2 systemd-journald[57]: Runtime Journal (/run/log/journal/c5a15fb9d5db49899fdf8acd57f1e5f3) is 8M, max 2.5G, 2.4G free.31machine1 # [1874276.215034] machine1 systemd[1]: Finished Apply Kernel Variables.32machine2 # [1874276.197080] machine2 systemd[1]: Finished Apply Kernel Variables.33machine1 # [1874276.232380] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.34machine2 # [1874276.208264] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.35machine1 # [1874276.248204] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...36machine2 # [1874276.220935] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...37machine1 # [1874276.249182] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...38machine2 # [1874276.221752] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...39machine1 # [1874276.259920] machine1 systemd-journald[57]: Time spent on flushing to /var/log/journal/51268db163cd4604833108c2934c98cd is 1.590ms for 6 entries.40machine2 # [1874276.232887] machine2 systemd-journald[57]: Time spent on flushing to /var/log/journal/c5a15fb9d5db49899fdf8acd57f1e5f3 is 2.358ms for 6 entries.41machine1 # [1874276.259920] machine1 systemd-journald[57]: System Journal (/var/log/journal/51268db163cd4604833108c2934c98cd) is 8M, max 4G, 3.9G free.42machine2 # [1874276.232887] machine2 systemd-journald[57]: System Journal (/var/log/journal/c5a15fb9d5db49899fdf8acd57f1e5f3) is 8M, max 4G, 3.9G free.43machine1 # [1874276.266744] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.44machine2 # [1874276.238370] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.45machine1 # [1874276.267440] machine1 systemd[1]: Reached target Preparation for Local File Systems.46machine2 # [1874276.238977] machine2 systemd[1]: Reached target Preparation for Local File Systems.47machine1 # [1874276.267572] machine1 systemd[1]: Reached target Local File Systems.48machine2 # [1874276.239101] machine2 systemd[1]: Reached target Local File Systems.49machine1 # [1874276.268425] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.50machine2 # [1874276.239886] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.51machine1 # [1874276.268476] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container52machine2 # [1874276.239930] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container53machine1 # [1874276.269438] machine1 systemd[1]: Starting Save Transient machine-id to Disk...54machine2 # [1874276.240730] machine2 systemd[1]: Starting Save Transient machine-id to Disk...55machine1 # [1874276.269477] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys56machine2 # [1874276.240764] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys57machine1 # [1874276.269940] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.58machine2 # [1874276.259289] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.59machine1 # [1874276.271456] machine1 systemd[1]: Starting Create System Files and Directories...60machine2 # [1874276.260895] machine2 systemd[1]: Starting Create System Files and Directories...61machine1 # [1874276.286274] machine1 systemd-tmpfiles[111]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted62machine2 # [1874276.280253] machine2 systemd-tmpfiles[110]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted63machine1 # [1874276.286450] machine1 systemd-tmpfiles[111]: fchmod() of /var/log/journal failed: Operation not permitted64machine2 # [1874276.280478] machine2 systemd-tmpfiles[110]: fchmod() of /var/log/journal failed: Operation not permitted65machine1 # [1874276.286573] machine1 systemd-tmpfiles[111]: fchmod() of /var/log/journal/51268db163cd4604833108c2934c98cd failed: Operation not permitted66machine2 # [1874276.280628] machine2 systemd-tmpfiles[110]: fchmod() of /var/log/journal/c5a15fb9d5db49899fdf8acd57f1e5f3 failed: Operation not permitted67machine1 # [1874276.286759] machine1 systemd-tmpfiles[111]: fchmod() of /run/log/journal failed: Operation not permitted68machine2 # [1874276.280853] machine2 systemd-tmpfiles[110]: fchmod() of /run/log/journal failed: Operation not permitted69machine1 # [1874276.288811] machine1 systemd[1]: Finished Create System Files and Directories.70machine2 # [1874276.282233] machine2 systemd[1]: Finished Create System Files and Directories.71machine1 # [1874276.289828] machine1 systemd[1]: Starting Rebuild Journal Catalog...72machine2 # [1874276.283391] machine2 systemd[1]: Starting Rebuild Journal Catalog...73machine1 # [1874276.290565] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...74machine2 # [1874276.284231] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...75machine1 # [1874276.304460] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.76machine2 # [1874276.299117] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.77machine1 # [1874276.314109] machine1 systemd[1]: Finished Rebuild Journal Catalog.78machine2 # [1874276.308188] machine2 systemd[1]: Finished Rebuild Journal Catalog.79machine1 # [1874276.315051] machine1 systemd[1]: Starting Update is Completed...80machine2 # [1874276.309565] machine2 systemd[1]: Starting Update is Completed...81machine1 # [1874276.325790] machine1 systemd[1]: Finished Update is Completed.82machine2 # [1874276.322394] machine2 systemd[1]: Finished Update is Completed.83machine1 # [1874276.325955] machine1 systemd[1]: Reached target System Initialization.84machine2 # [1874276.322593] machine2 systemd[1]: Reached target System Initialization.85machine1 # [1874276.326039] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container86machine2 # [1874276.322688] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container87machine1 # [1874276.326077] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.88machine2 # [1874276.322729] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.89machine1 # [1874276.326094] machine1 systemd[1]: Reached target Timer Units.90machine2 # [1874276.322753] machine2 systemd[1]: Reached target Timer Units.91machine1 # [1874276.326206] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.92machine2 # [1874276.322889] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.93machine1 # [1874276.326329] machine1 systemd[1]: Listening on Nix Daemon Socket.94machine2 # [1874276.323048] machine2 systemd[1]: Listening on Nix Daemon Socket.95machine1 # [1874276.327372] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).96machine2 # [1874276.324462] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).97machine1 # [1874276.328285] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).98machine2 # [1874276.325710] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).99machine1 # [1874276.328468] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.100machine2 # [1874276.325837] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.101machine1 # [1874276.328491] machine1 systemd[1]: Reached target Socket Units.102machine2 # [1874276.325863] machine2 systemd[1]: Reached target Socket Units.103machine1 # [1874276.328533] machine1 systemd[1]: Reached target Basic System.104machine2 # [1874276.325910] machine2 systemd[1]: Reached target Basic System.105machine1 # [1874276.329494] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...106machine2 # [1874276.327090] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...107machine1 # [1874276.330271] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...108machine2 # [1874276.328057] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...109machine1 # [1874276.330968] machine1 systemd[1]: Starting SSH Host Keys Generation...110machine2 # [1874276.328905] machine2 systemd[1]: Starting SSH Host Keys Generation...111machine2 # [1874276.348158] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.112machine2 # [1874276.368171] machine2 systemd[1]: Finished Firewall.113machine2 # [1874276.368365] machine2 systemd[1]: Reached target Preparation for Network.114machine2 # [1874276.369318] machine2 systemd[1]: Starting Address configuration of eth1...115machine2 # [1874276.370198] machine2 systemd[1]: Starting Extra networking commands....116machine2 # [1874276.391126] machine2 network-addresses-eth1-start[181]: adding address 192.168.1.2/24... done117machine2 # [1874276.393966] machine2 network-addresses-eth1-start[181]: adding address 2001:db8:1::2/64... done118machine2 # [1874276.398759] machine2 systemd[1]: Finished Address configuration of eth1.119machine2 # [1874276.441963] machine2 systemd[1]: nscd.service: Deactivated successfully.120machine2 # [1874276.442145] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).121machine2 # [1874276.444953] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...122machine2 # [1874276.452280] machine2 systemd[1]: Finished Extra networking commands..123machine2 # [1874276.452458] machine2 systemd[1]: Reached target Network.124machine1 # [1874276.356087] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.125machine1 # [1874276.373825] machine1 systemd[1]: Finished Firewall.126machine1 # [1874276.374037] machine1 systemd[1]: Reached target Preparation for Network.127machine1 # [1874276.375109] machine1 systemd[1]: Starting Address configuration of eth1...128machine1 # [1874276.376215] machine1 systemd[1]: Starting Extra networking commands....129machine1 # [1874276.395859] machine1 network-addresses-eth1-start[181]: adding address 192.168.1.1/24... done130machine1 # [1874276.399186] machine1 network-addresses-eth1-start[181]: adding address 2001:db8:1::1/64... done131machine1 # [1874276.403951] machine1 systemd[1]: Finished Address configuration of eth1.132machine1 # [1874276.448368] machine1 systemd[1]: nscd.service: Deactivated successfully.133machine1 # [1874276.448511] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).134machine1 # [1874276.451054] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...135machine1 # [1874276.458506] machine1 systemd[1]: Finished Extra networking commands..136machine1 # [1874276.458795] machine1 systemd[1]: Reached target Network.137machine1 # [1874276.576316] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).138machine1 # [1874276.576758] machine1 nsncd[241]: Sep 26 00:04:56.562 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"139machine1 # [1874276.576444] machine1 systemd[1]: Reached target Host and Network Name Lookups.140machine1 # [1874276.576554] machine1 systemd[1]: Reached target User and Group Name Lookups.141machine1 # [1874276.578753] machine1 systemd[1]: Starting User Login Management...142machine1 # [1874276.580018] machine1 systemd[1]: Starting Permit User Sessions...143machine1 # [1874276.617414] machine1 systemd[1]: Finished Permit User Sessions.144machine1 # [1874276.618998] machine1 systemd[1]: Started Console Getty.145machine1 # [1874276.619073] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0146machine1 # [1874276.619116] machine1 systemd[1]: Reached target Login Prompts.147machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: Generating public/private rsa key pair.148machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key149machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub150machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: The key fingerprint is:151machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: SHA256:uJ7AMi+8PIIZOAo9etbaBvY3vQz78HlDi9EpBTrdv/g root@machine1152machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: The key's randomart image is:153machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: +---[RSA 4096]----+154machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: | |155machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: | . |156machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: | o o |157machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: | o.. o |158machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: |.. ..So o |159machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: |= =. .o + . |160machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: |+Bo=o +. = o . |161machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: |*.*=+ooBo.= . |162machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: | ++*o.+o*o oE |163machine1 # [1874276.701445] machine1 sshd-keygen-start[167]: +----[SHA256]-----+164machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: Generating public/private ed25519 key pair.165machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key166machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub167machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: The key fingerprint is:168machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: SHA256:dwiADnQWyaxZrqwRDnqLmEy5MghnvmHJQ1rpSPLzzKc root@machine1169machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: The key's randomart image is:170machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: +--[ED25519 256]--+171machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: | ..o++. |172machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: | .o* . |173machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: | B . |174machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |o o.o . . |175machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |=+=. S o . |176machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |*%*. . . |177machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |OX@. |178machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |O+oB . |179machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: |....Eo |180machine1 # [1874276.719564] machine1 sshd-keygen-start[273]: +----[SHA256]-----+181machine1 # [1874276.721323] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.182machine1 # [1874276.721500] machine1 systemd[1]: Finished SSH Host Keys Generation.183machine1 # [1874276.722595] machine1 systemd[1]: Starting SSH Daemon...184machine1 # [1874276.780957] machine1 sshd[275]: Server listening on 0.0.0.0 port 22.185machine1 # [1874276.781009] machine1 sshd[275]: Server listening on :: port 22.186machine1 # [1874276.781430] machine1 systemd[1]: Started SSH Daemon.187machine2 # [1874276.576257] machine2 nsncd[241]: Sep 26 00:04:56.561 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"188machine2 # [1874276.576296] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).189machine2 # [1874276.576401] machine2 systemd[1]: Reached target Host and Network Name Lookups.190machine2 # [1874276.576511] machine2 systemd[1]: Reached target User and Group Name Lookups.191machine2 # [1874276.578573] machine2 systemd[1]: Starting User Login Management...192machine2 # [1874276.579909] machine2 systemd[1]: Starting Permit User Sessions...193machine2 # [1874276.618006] machine2 systemd[1]: Finished Permit User Sessions.194machine2 # [1874276.619612] machine2 systemd[1]: Started Console Getty.195machine2 # [1874276.619688] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0196machine2 # [1874276.619726] machine2 systemd[1]: Reached target Login Prompts.197machine1 # [1874277.227021] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.198machine1 # [1874277.228066] machine1 systemd[1]: Finished Save Transient machine-id to Disk.199machine1 # [1874277.349457] machine1 systemd-logind[258]: New seat seat0.200machine1 # [1874277.349752] machine1 systemd[1]: Started User Login Management.201machine1 # [1874277.351358] machine1 systemd[1]: Starting D-Bus System Message Bus...202machine1 # [1874277.352808] machine1 systemd[1]: Starting linger-users.service...203machine1 # [1874277.398493] machine1 systemd[1]: linger-users.service: Deactivated successfully.204machine1 # [1874277.398757] machine1 systemd[1]: Finished linger-users.service.205machine1 # [1874277.399174] machine1 systemd[1]: Reached target Multi-User System.206machine2 # [1874277.219792] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.207machine2 # [1874277.220877] machine2 systemd[1]: Finished Save Transient machine-id to Disk.208machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: Generating public/private rsa key pair.209machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key210machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub211machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: The key fingerprint is:212machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: SHA256:DKakXQ4r5MeFIqCeRhsVnBYYvaMOA++iwuF6Tk9lXFE root@machine2213machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: The key's randomart image is:214machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: +---[RSA 4096]----+215machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |..=++ ..E |216machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |o..= . . |217machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |oo+ = = . |218machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |+++O X + |219machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |.*= B = S |220machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |+o.o o |221machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |=oo . |222machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |o=oo |223machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: |*+. . |224machine2 # [1874277.222433] machine2 sshd-keygen-start[171]: +----[SHA256]-----+225machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: Generating public/private ed25519 key pair.226machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key227machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub228machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: The key fingerprint is:229machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: SHA256:nmenXVnBnXuAj6pRb6c/YFWT1Im1PM8O2UfrzAnA+u0 root@machine2230machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: The key's randomart image is:231machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: +--[ED25519 256]--+232machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | +o+|233machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | . oo+*|234machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | o. .O+|235machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | . .o.**|236machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | S.. .o+oB|237machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | . o.o+ ==+|238machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | + +o+o+=.|239machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | = =.+. |240machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: | . . oE.. |241machine2 # [1874277.239107] machine2 sshd-keygen-start[274]: +----[SHA256]-----+242machine2 # [1874277.240895] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.243machine2 # [1874277.241050] machine2 systemd[1]: Finished SSH Host Keys Generation.244machine2 # [1874277.241091] machine2 systemd[1]: sshd-keygen.service: Consumed 1.295s CPU time over 912ms wall clock time.245machine2 # [1874277.242088] machine2 systemd[1]: Starting SSH Daemon...246machine2 # [1874277.292978] machine2 sshd[276]: Server listening on 0.0.0.0 port 22.247machine2 # [1874277.293018] machine2 sshd[276]: Server listening on :: port 22.248machine2 # [1874277.293334] machine2 systemd[1]: Started SSH Daemon.249machine2 # [1874277.367708] machine2 systemd-logind[258]: New seat seat0.250machine2 # [1874277.368072] machine2 systemd[1]: Started User Login Management.251machine2 # [1874277.388588] machine2 systemd[1]: Starting D-Bus System Message Bus...252machine2 # [1874277.389806] machine2 systemd[1]: Starting linger-users.service...253machine2 # [1874277.402712] machine2 systemd[1]: linger-users.service: Deactivated successfully.254machine2 # [1874277.402845] machine2 systemd[1]: Finished linger-users.service.255machine2 # [1874277.403173] machine2 systemd[1]: Reached target Multi-User System.256machine1 # [1874277.659005] machine1 dbus-broker-launch[277]: Looking up NSS user entry for 'systemd-timesync'...257machine2 # [1874277.636542] machine2 dbus-broker-launch[277]: Looking up NSS user entry for 'systemd-timesync'...258machine1 # [1874277.659961] machine1 dbus-broker-launch[277]: NSS returned no entry for 'systemd-timesync'259machine2 # [1874277.637939] machine2 dbus-broker-launch[277]: NSS returned no entry for 'systemd-timesync'260machine1 # [1874277.659961] machine1 dbus-broker-launch[277]: Invalid user-name in /nix/store/q2j5z2r3vaff2mz4g5abjanb05bzg12a-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"261machine2 # [1874277.637939] machine2 dbus-broker-launch[277]: Invalid user-name in /nix/store/q2j5z2r3vaff2mz4g5abjanb05bzg12a-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"262machine1 # [1874277.660477] machine1 systemd[1]: Started D-Bus System Message Bus.263machine2 # [1874277.638731] machine2 systemd[1]: Started D-Bus System Message Bus.264machine1 # [1874277.660973] machine1 systemd[1]: Startup finished in 1.853s.265machine2 # [1874277.639284] machine2 systemd[1]: Startup finished in 1.825s.266machine1 # [1874277.668562] machine1 dbus-broker-launch[277]: Ready267machine2 # [1874277.647582] machine2 dbus-broker-launch[277]: Ready268machine1: (finished: must succeed: systemctl status sshd, in 2.65 seconds)269machine2: must succeed: systemctl status sshd270machine2: (finished: must succeed: systemctl status sshd, in 0.02 seconds)271machine1: waiting for unit sshd272machine1: (finished: waiting for unit sshd, in 0.01 seconds)273machine2: waiting for unit sshd274machine2: (finished: waiting for unit sshd, in 0.01 seconds)275machine1: must succeed: ip addr show eth1276machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)277machine2: must succeed: ip addr show eth1278machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)279machine1: must succeed: ping -c 1 machine2280machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)281(finished: run the VM test script, in 2.73 seconds)282test script finished in 2.77s283cleanup284kill NspawnMachine (pid 52)285kill NspawnMachine (pid 53)286Container machine1 terminated by signal KILL.287(finished: cleanup, in 0.33 seconds)288Container machine2 terminated by signal KILL.