container-test-run-container
checks.aarch64-linux.nixos-test-container
· build #1046
· raw
1build01: building rjsbw1hihkijss9vas4nc7nlai54hmpd-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 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(machine2): TAP vde-tap1 not found; container will be isolated from VDE20nixos-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.21nixos-nspawn(machine1): TAP vde-tap1 not found; container will be isolated from VDE22nixos-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.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 # [348423.529371] machine1 systemd-journald[58]: Journal started28machine2 # [348423.544072] machine2 systemd-journald[58]: Journal started29machine1 # [348423.529426] machine1 systemd-journald[58]: Runtime Journal (/run/log/journal/3d411f8239094aa7abc3b1adf507a14a) is 8M, max 2.5G, 2.4G free.30machine2 # [348423.544145] machine2 systemd-journald[58]: Runtime Journal (/run/log/journal/b39dbd00c6b64662bca565fcf87ea593) is 8M, max 2.5G, 2.4G free.31machine1 # [348423.603907] machine1 systemd[1]: Finished Apply Kernel Variables.32machine2 # [348423.568816] machine2 systemd[1]: Finished Apply Kernel Variables.33machine1 # [348423.629555] machine1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.34machine2 # [348423.587321] machine2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully.35machine1 # [348423.664518] machine1 systemd[1]: Starting Flush Journal to Persistent Storage...36machine2 # [348423.610910] machine2 systemd[1]: Starting Flush Journal to Persistent Storage...37machine1 # [348423.665408] machine1 systemd[1]: Starting Create Static Device Nodes in /dev...38machine2 # [348423.611729] machine2 systemd[1]: Starting Create Static Device Nodes in /dev...39machine1 # [348423.673424] machine1 systemd-journald[58]: Time spent on flushing to /var/log/journal/3d411f8239094aa7abc3b1adf507a14a is 1.690ms for 6 entries.40machine2 # [348423.671492] machine2 systemd-journald[58]: Time spent on flushing to /var/log/journal/b39dbd00c6b64662bca565fcf87ea593 is 1.582ms for 6 entries.41machine1 # [348423.673424] machine1 systemd-journald[58]: System Journal (/var/log/journal/3d411f8239094aa7abc3b1adf507a14a) is 8M, max 4G, 3.9G free.42machine2 # [348423.671492] machine2 systemd-journald[58]: System Journal (/var/log/journal/b39dbd00c6b64662bca565fcf87ea593) is 8M, max 4G, 3.9G free.43machine1 # [348423.704340] machine1 systemd[1]: Finished Firewall.44machine2 # [348423.710478] machine2 systemd[1]: Finished Firewall.45machine1 # [348423.704582] machine1 systemd[1]: Finished Flush Journal to Persistent Storage.46machine2 # [348423.711103] machine2 systemd[1]: Finished Flush Journal to Persistent Storage.47machine1 # [348423.705714] machine1 systemd[1]: Finished Create Static Device Nodes in /dev.48machine2 # [348423.711932] machine2 systemd[1]: Finished Create Static Device Nodes in /dev.49machine1 # [348423.708396] machine1 systemd[1]: Reached target Preparation for Local File Systems.50machine2 # [348423.714425] machine2 systemd[1]: Reached target Preparation for Local File Systems.51machine1 # [348423.708533] machine1 systemd[1]: Reached target Local File Systems.52machine2 # [348423.714576] machine2 systemd[1]: Reached target Local File Systems.53machine1 # [348423.708608] machine1 systemd[1]: Reached target Preparation for Network.54machine2 # [348423.714663] machine2 systemd[1]: Reached target Preparation for Network.55machine1 # [348423.709471] machine1 systemd[1]: Listening on Boot Loader Control Service Socket.56machine2 # [348423.715675] machine2 systemd[1]: Listening on Boot Loader Control Service Socket.57machine1 # [348423.709534] machine1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container58machine2 # [348423.715764] machine2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container59machine1 # [348423.710662] machine1 systemd[1]: Starting Save Transient machine-id to Disk...60machine2 # [348423.717120] machine2 systemd[1]: Starting Save Transient machine-id to Disk...61machine1 # [348423.711578] machine1 systemd[1]: Starting Create System Files and Directories...62machine2 # [348423.718158] machine2 systemd[1]: Starting Create System Files and Directories...63machine1 # [348423.711625] machine1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys64machine2 # [348423.718203] machine2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys65machine1 # [348423.729469] machine1 systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted66machine1 # [348423.729703] machine1 systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted67machine1 # [348423.729865] machine1 systemd-tmpfiles[161]: fchmod() of /var/log/journal/3d411f8239094aa7abc3b1adf507a14a failed: Operation not permitted68machine1 # [348423.730094] machine1 systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted69machine2 # [348423.733604] machine2 systemd-tmpfiles[161]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted70machine2 # [348423.733769] machine2 systemd-tmpfiles[161]: fchmod() of /var/log/journal failed: Operation not permitted71machine2 # [348423.733879] machine2 systemd-tmpfiles[161]: fchmod() of /var/log/journal/b39dbd00c6b64662bca565fcf87ea593 failed: Operation not permitted72machine2 # [348423.734039] machine2 systemd-tmpfiles[161]: fchmod() of /run/log/journal failed: Operation not permitted73machine1 # [348423.731875] machine1 systemd[1]: Finished Create System Files and Directories.74machine1 # [348423.733186] machine1 systemd[1]: Starting Rebuild Journal Catalog...75machine1 # [348423.734027] machine1 systemd[1]: Starting Record System Boot/Shutdown in UTMP...76machine1 # [348423.748213] machine1 systemd[1]: Finished Record System Boot/Shutdown in UTMP.77machine1 # [348423.758156] machine1 systemd[1]: Finished Rebuild Journal Catalog.78machine1 # [348423.759209] machine1 systemd[1]: Starting Update is Completed...79machine1 # [348423.769736] machine1 systemd[1]: Finished Update is Completed.80machine1 # [348423.769932] machine1 systemd[1]: Reached target System Initialization.81machine1 # [348423.770012] machine1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container82machine1 # [348423.770050] machine1 systemd[1]: Started Daily Cleanup of Temporary Directories.83machine1 # [348423.770069] machine1 systemd[1]: Reached target Timer Units.84machine1 # [348423.770189] machine1 systemd[1]: Listening on D-Bus System Message Bus Socket.85machine1 # [348423.770325] machine1 systemd[1]: Listening on Nix Daemon Socket.86machine1 # [348423.771212] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).87machine1 # [348423.771837] machine1 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).88machine1 # [348423.771935] machine1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.89machine1 # [348423.771957] machine1 systemd[1]: Reached target Socket Units.90machine1 # [348423.771996] machine1 systemd[1]: Reached target Basic System.91machine1 # [348423.773115] machine1 systemd[1]: Starting Import lastlog data into lastlog2 database...92machine1 # [348423.773953] machine1 systemd[1]: Starting Address configuration of eth1...93machine1 # [348423.774955] machine1 systemd[1]: Starting Extra networking commands....94machine1 # [348423.775849] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...95machine1 # [348423.777022] machine1 systemd[1]: Starting SSH Host Keys Generation...96machine1 # [348423.777806] machine1 systemd[1]: Finished Save Transient machine-id to Disk.97machine1 # [348423.792931] machine1 systemd[1]: Finished Import lastlog data into lastlog2 database.98machine1 # [348423.794877] machine1 network-addresses-eth1-start[170]: adding address 192.168.1.1/24... done99machine1 # [348423.797508] machine1 network-addresses-eth1-start[170]: adding address 2001:db8:1::1/64... done100machine1 # [348423.801960] machine1 systemd[1]: Finished Address configuration of eth1.101machine1 # [348423.844814] machine1 systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available102machine1 # [348423.844857] machine1 systemd[1]: nscd.service: Deactivated successfully.103machine1 # [348423.845103] machine1 systemd[1]: Stopped Name Service Cache Daemon (nsncd).104machine1 # [348423.847508] machine1 systemd[1]: Starting Name Service Cache Daemon (nsncd)...105machine1 # [348423.848775] machine1 systemd[1]: Finished Extra networking commands..106machine1 # [348423.848959] machine1 systemd[1]: Reached target Network.107machine2 # [348423.735684] machine2 systemd[1]: Finished Create System Files and Directories.108machine2 # [348423.736865] machine2 systemd[1]: Starting Rebuild Journal Catalog...109machine2 # [348423.737715] machine2 systemd[1]: Starting Record System Boot/Shutdown in UTMP...110machine2 # [348423.751516] machine2 systemd[1]: Finished Record System Boot/Shutdown in UTMP.111machine2 # [348423.757144] machine2 systemd[1]: Finished Rebuild Journal Catalog.112machine2 # [348423.758818] machine2 systemd[1]: Starting Update is Completed...113machine2 # [348423.769571] machine2 systemd[1]: Finished Update is Completed.114machine2 # [348423.769850] machine2 systemd[1]: Finished Save Transient machine-id to Disk.115machine2 # [348423.770572] machine2 systemd[1]: Reached target System Initialization.116machine2 # [348423.770671] machine2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container117machine2 # [348423.770717] machine2 systemd[1]: Started Daily Cleanup of Temporary Directories.118machine2 # [348423.770737] machine2 systemd[1]: Reached target Timer Units.119machine2 # [348423.770859] machine2 systemd[1]: Listening on D-Bus System Message Bus Socket.120machine2 # [348423.770978] machine2 systemd[1]: Listening on Nix Daemon Socket.121machine2 # [348423.771870] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).122machine2 # [348423.772914] machine2 systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).123machine2 # [348423.773040] machine2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.124machine2 # [348423.773065] machine2 systemd[1]: Reached target Socket Units.125machine2 # [348423.773113] machine2 systemd[1]: Reached target Basic System.126machine2 # [348423.774189] machine2 systemd[1]: Starting Import lastlog data into lastlog2 database...127machine2 # [348423.775112] machine2 systemd[1]: Starting Address configuration of eth1...128machine2 # [348423.775972] machine2 systemd[1]: Starting Extra networking commands....129machine2 # [348423.776804] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...130machine2 # [348423.777562] machine2 systemd[1]: Starting SSH Host Keys Generation...131machine2 # [348423.793373] machine2 network-addresses-eth1-start[171]: adding address 192.168.1.2/24... done132machine2 # [348423.794413] machine2 systemd[1]: Finished Import lastlog data into lastlog2 database.133machine2 # [348423.795949] machine2 network-addresses-eth1-start[171]: adding address 2001:db8:1::2/64... done134machine2 # [348423.800437] machine2 systemd[1]: Finished Address configuration of eth1.135machine2 # [348423.845148] machine2 systemd[1]: nscd.service: Failed to read pids.max for control group /system.slice/nscd.service, ignoring: No data available136machine2 # [348423.845170] machine2 systemd[1]: nscd.service: Deactivated successfully.137machine2 # [348423.845246] machine2 systemd[1]: Stopped Name Service Cache Daemon (nsncd).138machine2 # [348423.847334] machine2 systemd[1]: Starting Name Service Cache Daemon (nsncd)...139machine2 # [348423.849875] machine2 systemd[1]: Finished Extra networking commands..140machine2 # [348423.850057] machine2 systemd[1]: Reached target Network.141machine1 # [348424.077771] machine1 nsncd[247]: Oct 20 10:10:29.049 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"142machine1 # [348424.077929] machine1 systemd[1]: Started Name Service Cache Daemon (nsncd).143machine1 # [348424.077994] machine1 systemd[1]: Reached target Host and Network Name Lookups.144machine1 # [348424.078051] machine1 systemd[1]: Reached target User and Group Name Lookups.145machine1 # [348424.079655] machine1 systemd[1]: Starting User Login Management...146machine1 # [348424.080491] machine1 systemd[1]: Starting Permit User Sessions...147machine1 # [348424.130747] machine1 systemd[1]: Finished Permit User Sessions.148machine1 # [348424.131885] machine1 systemd[1]: Started Console Getty.149machine1 # [348424.131925] machine1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0150machine1 # [348424.131943] machine1 systemd[1]: Reached target Login Prompts.151machine2 # [348424.077333] machine2 systemd[1]: Started Name Service Cache Daemon (nsncd).152machine2 # [348424.078016] machine2 nsncd[247]: Oct 20 10:10:29.049 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"153machine2 # [348424.077433] machine2 systemd[1]: Reached target Host and Network Name Lookups.154machine2 # [348424.077512] machine2 systemd[1]: Reached target User and Group Name Lookups.155machine2 # [348424.079404] machine2 systemd[1]: Starting User Login Management...156machine2 # [348424.080443] machine2 systemd[1]: Starting Permit User Sessions...157machine2 # [348424.131408] machine2 systemd[1]: Finished Permit User Sessions.158machine2 # [348424.132423] machine2 systemd[1]: Started Console Getty.159machine2 # [348424.132463] machine2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0160machine2 # [348424.132481] machine2 systemd[1]: Reached target Login Prompts.161machine1 # [348424.561140] machine1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.162machine2 # [348424.562456] machine2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.163machine2 # [348425.717009] machine2 systemd-logind[260]: New seat seat0.164machine2 # [348425.718023] machine2 systemd[1]: Starting D-Bus System Message Bus...165machine2 # [348425.718234] machine2 systemd[1]: Started User Login Management.166machine2 # [348425.719132] machine2 systemd[1]: Starting linger-users.service...167machine2 # [348425.730349] machine2 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available168machine2 # [348425.730394] machine2 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available169machine2 # [348425.730422] machine2 systemd[1]: linger-users.service: Deactivated successfully.170machine2 # [348425.730696] machine2 systemd[1]: Finished linger-users.service.171machine2 # [348425.937510] machine2 sshd-keygen-start[195]: Generating public/private rsa key pair.172machine2 # [348425.937510] machine2 sshd-keygen-start[195]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key173machine2 # [348425.937510] machine2 sshd-keygen-start[195]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub174machine2 # [348425.937510] machine2 sshd-keygen-start[195]: The key fingerprint is:175machine2 # [348425.937510] machine2 sshd-keygen-start[195]: SHA256:pocs/KtrGFj/JpMwEUROcpDrk+xdhUn1yqXT0Gp7AlU root@machine2176machine2 # [348425.937510] machine2 sshd-keygen-start[195]: The key's randomart image is:177machine2 # [348425.937510] machine2 sshd-keygen-start[195]: +---[RSA 4096]----+178machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |o== .. E |179machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |.=. . + |180machine2 # [348425.937510] machine2 sshd-keygen-start[195]: | .... oo + |181machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |. o oo.B |182machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |oo.o ..BS. |183machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |.=+..oo+o |184machine2 # [348425.937510] machine2 sshd-keygen-start[195]: |. o=+o+o.. |185machine2 # [348425.937510] machine2 sshd-keygen-start[195]: | ...=oo.o |186machine2 # [348425.937510] machine2 sshd-keygen-start[195]: | .o*o. |187machine2 # [348425.937510] machine2 sshd-keygen-start[195]: +----[SHA256]-----+188machine2 # [348425.951239] machine2 sshd-keygen-start[279]: Generating public/private ed25519 key pair.189machine2 # [348425.951239] machine2 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key190machine2 # [348425.951239] machine2 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub191machine2 # [348425.951239] machine2 sshd-keygen-start[279]: The key fingerprint is:192machine2 # [348425.951239] machine2 sshd-keygen-start[279]: SHA256:+HO6yVT8FiVzsxY+G1D1HzWj3mzWs4cVuiWa7VxAjxo root@machine2193machine2 # [348425.951239] machine2 sshd-keygen-start[279]: The key's randomart image is:194machine2 # [348425.951239] machine2 sshd-keygen-start[279]: +--[ED25519 256]--+195machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | .+o|196machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | .. =|197machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | +o=o.|198machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | . . oB*+=|199machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | . S oE.**O+|200machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | . . .*oB*o|201machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | + .+oooo.|202machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | o = .o . .|203machine2 # [348425.951239] machine2 sshd-keygen-start[279]: | =. o |204machine2 # [348425.951239] machine2 sshd-keygen-start[279]: +----[SHA256]-----+205machine2 # [348425.952824] machine2 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available206machine2 # [348425.952863] machine2 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available207machine2 # [348425.952893] machine2 systemd[1]: sshd-keygen.service: Deactivated successfully.208machine2 # [348425.953046] machine2 systemd[1]: Finished SSH Host Keys Generation.209machine2 # [348425.953124] machine2 systemd[1]: sshd-keygen.service: Consumed 4.343s CPU time over 2.175s wall clock time.210machine2 # [348425.954249] machine2 systemd[1]: Starting SSH Daemon...211machine1 # [348425.739882] machine1 systemd-logind[253]: New seat seat0.212machine1 # [348425.740612] machine1 systemd[1]: Started User Login Management.213machine1 # [348425.742362] machine1 systemd[1]: Starting D-Bus System Message Bus...214machine1 # [348425.743916] machine1 systemd[1]: Starting linger-users.service...215machine1 # [348425.761115] machine1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available216machine1 # [348425.761160] machine1 systemd[1]: linger-users.service: Failed to read pids.max for control group /system.slice/linger-users.service, ignoring: No data available217machine1 # [348425.761224] machine1 systemd[1]: linger-users.service: Deactivated successfully.218machine1 # [348425.761492] machine1 systemd[1]: Finished linger-users.service.219machine2 # [348425.972123] machine2 sshd[281]: Server listening on 0.0.0.0 port 22.220machine2 # [348425.972149] machine2 sshd[281]: Server listening on :: port 22.221machine2 # [348425.972418] machine2 systemd[1]: Started SSH Daemon.222machine2 # [348425.972481] machine2 systemd[1]: Reached target Multi-User System.223machine1 # [348426.331581] machine1 sshd-keygen-start[202]: Generating public/private rsa key pair.224machine1 # [348426.331581] machine1 sshd-keygen-start[202]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key225machine1 # [348426.331581] machine1 sshd-keygen-start[202]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub226machine1 # [348426.331581] machine1 sshd-keygen-start[202]: The key fingerprint is:227machine1 # [348426.331581] machine1 sshd-keygen-start[202]: SHA256:5EZw3KequHlNigqBmWSZeKGqqdBYHdAu5c69PkZnMbk root@machine1228machine1 # [348426.331581] machine1 sshd-keygen-start[202]: The key's randomart image is:229machine1 # [348426.331581] machine1 sshd-keygen-start[202]: +---[RSA 4096]----+230machine1 # [348426.331581] machine1 sshd-keygen-start[202]: | o. .... |231machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |..ooo o. . . |232machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |o=.+. o. o |233machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |=+..o. ++ . |234machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |* .+.. S= |235machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |.* o o.E |236machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |* . + O |237machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |o. o.B . |238machine1 # [348426.331581] machine1 sshd-keygen-start[202]: |. ..o=.. |239machine1 # [348426.331581] machine1 sshd-keygen-start[202]: +----[SHA256]-----+240machine1 # [348426.355636] machine1 sshd-keygen-start[279]: Generating public/private ed25519 key pair.241machine1 # [348426.355636] machine1 sshd-keygen-start[279]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key242machine1 # [348426.355636] machine1 sshd-keygen-start[279]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub243machine1 # [348426.355636] machine1 sshd-keygen-start[279]: The key fingerprint is:244machine1 # [348426.355636] machine1 sshd-keygen-start[279]: SHA256:SY4lleZFwzSRU6oHuOBzvuzfritfNKw7lB/23jGZKEc root@machine1245machine1 # [348426.355636] machine1 sshd-keygen-start[279]: The key's randomart image is:246machine1 # [348426.355636] machine1 sshd-keygen-start[279]: +--[ED25519 256]--+247machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | .=*+. |248machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | oo =+ |249machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | . oo+... |250machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | . . B.= |251machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | o + S.= E |252machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | + o+oo . o |253machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | ...oooo = |254machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | ....+.o.. o |255machine1 # [348426.355636] machine1 sshd-keygen-start[279]: | .++*=o.. . |256machine1 # [348426.355636] machine1 sshd-keygen-start[279]: +----[SHA256]-----+257machine1 # [348426.364146] machine1 dbus-broker-launch[270]: Looking up NSS user entry for 'systemd-timesync'...258machine1 # [348426.380400] machine1 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available259machine1 # [348426.380422] machine1 systemd[1]: sshd-keygen.service: Failed to read pids.max for control group /system.slice/sshd-keygen.service, ignoring: No data available260machine1 # [348426.380448] machine1 systemd[1]: sshd-keygen.service: Deactivated successfully.261machine1 # [348426.380541] machine1 systemd[1]: Finished SSH Host Keys Generation.262machine1 # [348426.381741] machine1 dbus-broker-launch[270]: NSS returned no entry for 'systemd-timesync'263machine1 # [348426.381741] machine1 dbus-broker-launch[270]: Invalid user-name in /nix/store/6zv9wpf6gdlklkm890fsgww8831kinbj-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"264machine1 # [348426.382017] machine1 systemd[1]: Starting SSH Daemon...265machine1 # [348426.382368] machine1 systemd[1]: Started D-Bus System Message Bus.266machine1 # [348426.389943] machine1 dbus-broker-launch[270]: Ready267machine1 # [348426.400172] machine1 sshd[281]: Server listening on 0.0.0.0 port 22.268machine1 # [348426.400197] machine1 sshd[281]: Server listening on :: port 22.269machine1 # [348426.400439] machine1 systemd[1]: Started SSH Daemon.270machine1 # [348426.400706] machine1 systemd[1]: Reached target Multi-User System.271machine1 # [348426.401343] machine1 systemd[1]: Startup finished in 3.266s.272machine2 # [348426.330519] machine2 dbus-broker-launch[270]: Looking up NSS user entry for 'systemd-timesync'...273machine2 # [348426.330519] machine2 dbus-broker-launch[270]: NSS returned no entry for 'systemd-timesync'274machine2 # [348426.330519] machine2 dbus-broker-launch[270]: Invalid user-name in /nix/store/6zv9wpf6gdlklkm890fsgww8831kinbj-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"275machine2 # [348426.330625] machine2 systemd[1]: Started D-Bus System Message Bus.276machine2 # [348426.331145] machine2 systemd[1]: Startup finished in 3.201s.277machine2 # [348426.340042] machine2 dbus-broker-launch[270]: Ready278machine1: (finished: must succeed: systemctl status sshd, in 4.15 seconds)279machine2: must succeed: systemctl status sshd280machine2: (finished: must succeed: systemctl status sshd, in 0.01 seconds)281machine1: waiting for unit sshd282machine1: (finished: waiting for unit sshd, in 0.01 seconds)283machine2: waiting for unit sshd284machine2: (finished: waiting for unit sshd, in 0.01 seconds)285machine1: must succeed: ip addr show eth1286machine1: (finished: must succeed: ip addr show eth1, in 0.01 seconds)287machine2: must succeed: ip addr show eth1288machine2: (finished: must succeed: ip addr show eth1, in 0.01 seconds)289machine1: must succeed: ping -c 1 machine2290machine1: (finished: must succeed: ping -c 1 machine2, in 0.01 seconds)291(finished: run the VM test script, in 4.21 seconds)292test script finished in 4.25s293cleanup294kill 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)