don't know how to build these paths: /nix/store/r1l50fliaxzzfz33y5yfgxchvfkfz6mz-container-test-run-sshd.drv warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/11wlll69wfibgak8acjmlrz30fbhviii-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> gi-build-x86-02: building 11wlll69wfibgak8acjmlrz30fbhviii-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/wwciwpdng7qmcz5xpdga5mfmzd8i9q2c-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> attached to the build already running on this worker unit-dbus-broker.service> gi-build-x86-02: building wwciwpdng7qmcz5xpdga5mfmzd8i9q2c-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/7r3yrry8lch75xmkpjq6r4hqbvrizy38-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building 7r3yrry8lch75xmkpjq6r4hqbvrizy38-etc.drv building '/nix/store/ps7f5wsb7qpv4y57kawfpz9iixqil7jn-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building ps7f5wsb7qpv4y57kawfpz9iixqil7jn-activate.drv building '/nix/store/kq4xv6hn59643d1bc6xsxd2khxmp8xa6-user-units.drv' on nix-store.geninf.io:50051 user-units> attached to the build already running on this worker user-units> gi-build-x86-02: building kq4xv6hn59643d1bc6xsxd2khxmp8xa6-user-units.drv activate> structuredAttrs is enabled building '/nix/store/nrx8l8dfcfar7mdii4vczkfi1dk1phq2-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building nrx8l8dfcfar7mdii4vczkfi1dk1phq2-system-units.drv building '/nix/store/81prijzkv3dhnpl838c41cbd835ks0w5-nixos-system-client-test.drv' on nix-store.geninf.io:50051 nixos-system-client-test> build-x86-01: building 81prijzkv3dhnpl838c41cbd835ks0w5-nixos-system-client-test.drv nixos-system-client-test> structuredAttrs is enabled building '/nix/store/97fjhrvhrbx07wimzy7bpa6ksndsp4i6-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building 97fjhrvhrbx07wimzy7bpa6ksndsp4i6-etc.drv building '/nix/store/8g6k873rah6gzxxi9gbv3gn9l8973d9z-run-client-nspawn.drv' on nix-store.geninf.io:50051 run-client-nspawn> build-x86-01: building 8g6k873rah6gzxxi9gbv3gn9l8973d9z-run-client-nspawn.drv building '/nix/store/szbc94xb0lw0wzir0hfpwxsfvkhr0rac-activate.drv' on nix-store.geninf.io:50051 activate> gi-build-x86-02: building szbc94xb0lw0wzir0hfpwxsfvkhr0rac-activate.drv activate> structuredAttrs is enabled building '/nix/store/2089ixacgz6znml3y17vkhb1i0y4qvgq-nixos-system-server-test.drv' on nix-store.geninf.io:50051 nixos-system-server-test> gi-build-x86-02: building 2089ixacgz6znml3y17vkhb1i0y4qvgq-nixos-system-server-test.drv nixos-system-server-test> structuredAttrs is enabled building '/nix/store/c90kxbr95m61pa96i2d01k65ii3zr6m0-run-server-nspawn.drv' on nix-store.geninf.io:50051 run-server-nspawn> gi-build-x86-02: building c90kxbr95m61pa96i2d01k65ii3zr6m0-run-server-nspawn.drv building '/nix/store/78i5h2d6fcrazja59vlczr8ilh4znmqr-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> gi-build-x86-02: building 78i5h2d6fcrazja59vlczr8ilh4znmqr-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/hr6fd250ab54b9ky3barp65gps2h0qc8-nixos-test-driver-sshd.drv' on nix-store.geninf.io:50051 nixos-test-driver-sshd> gi-build-x86-02: building hr6fd250ab54b9ky3barp65gps2h0qc8-nixos-test-driver-sshd.drv nixos-test-driver-sshd> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-sshd> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-sshd> All checks passed! nixos-test-driver-sshd> Linting test script (enable/disable: config.skipLint) nixos-test-driver-sshd> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-sshd> All checks passed! building '/nix/store/r1l50fliaxzzfz33y5yfgxchvfkfz6mz-container-test-run-sshd.drv' on nix-store.geninf.io:50051 container-test-run-sshd> build-x86-01: building r1l50fliaxzzfz33y5yfgxchvfkfz6mz-container-test-run-sshd.drv container-test-run-sshd> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-sshd> start all VLans container-test-run-sshd> (finished: start all VLans, in 0.00 seconds) container-test-run-sshd> container-test-run-sshd> Test will time out and terminate in 3600.0 seconds container-test-run-sshd> run the VM test script container-test-run-sshd> additionally exposed symbols: container-test-run-sshd> client, server, container-test-run-sshd> vlan1, container-test-run-sshd> 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_ssh container-test-run-sshd> ??? Warning (SyntaxWarning): "\*" is an invalid escape sequence. Such sequences will not work in the future. Did you mean "\\*"? A raw string is also an option. container-test-run-sshd> File "", line 7 container-test-run-sshd> ??? Warning (SyntaxWarning): "\*" is an invalid escape sequence. Such sequences will not work in the future. Did you mean "\\*"? A raw string is also an option. container-test-run-sshd> File "", line 13 container-test-run-sshd> start all VMs container-test-run-sshd> client: systemd-nspawn running (pid 52) container-test-run-sshd> client: Waiting for journal at /build/vm-state-client/var/log/journal... container-test-run-sshd> server: systemd-nspawn running (pid 53) container-test-run-sshd> server: Waiting for journal at /build/vm-state-server/var/log/journal... container-test-run-sshd> (finished: start all VMs, in 0.00 seconds) container-test-run-sshd> server: must succeed: /nix/store/z3kz5w81zc0jnc7vpnfq6p5rgai0j291-libressl-4.3.2-nc/bin/nc -z -v 127.0.0.1 22 container-test-run-sshd> nixos-nspawn(server): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-sshd> nixos-nspawn(server): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-sshd> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-sshd> nixos-nspawn(client): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-sshd> Note: 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. container-test-run-sshd> Note: 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. container-test-run-sshd> ░ Spawning container server on /build/vm-state-server. container-test-run-sshd> ░ Spawning container client on /build/vm-state-client. container-test-run-sshd> client # [2465565.700046] client systemd-journald[72]: Journal started container-test-run-sshd> client # [2465565.700077] client systemd-journald[72]: Runtime Journal (/run/log/journal/22f404c53eec45dba51db1bfec26f722) is 8M, max 3.7G, 3.7G free. container-test-run-sshd> client # [2465565.704899] client systemd[1]: Finished Apply Kernel Variables. container-test-run-sshd> client # [2465565.711297] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-sshd> client # [2465565.718641] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-sshd> client # [2465565.718994] client systemd[1]: Starting Network Name Resolution... container-test-run-sshd> client # [2465565.719297] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-sshd> client # [2465565.723538] client systemd-journald[72]: Time spent on flushing to /var/log/journal/22f404c53eec45dba51db1bfec26f722 is 1.238ms for 7 entries. container-test-run-sshd> client # [2465565.723538] client systemd-journald[72]: System Journal (/var/log/journal/22f404c53eec45dba51db1bfec26f722) is 8M, max 4G, 3.9G free. container-test-run-sshd> client # [2465565.729752] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-sshd> client # [2465565.730532] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-sshd> client # [2465565.731502] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-sshd> client # [2465565.731556] client systemd[1]: Reached target Local File Systems. container-test-run-sshd> client # [2465565.732064] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-sshd> client # [2465565.732090] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> client # [2465565.732525] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-sshd> client # [2465565.732846] client systemd[1]: Starting Create System Files and Directories... container-test-run-sshd> client # [2465565.732858] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-sshd> client # [2465565.747290] client systemd-tmpfiles[125]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-sshd> client # [2465565.747439] client systemd-tmpfiles[125]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-sshd> client # [2465565.747538] client systemd-tmpfiles[125]: fchmod() of /var/log/journal/22f404c53eec45dba51db1bfec26f722 failed: Operation not permitted container-test-run-sshd> client # [2465565.747680] client systemd-tmpfiles[125]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-sshd> client # [2465565.748835] client systemd[1]: Finished Create System Files and Directories. container-test-run-sshd> client # [2465565.749379] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-sshd> client # [2465565.749875] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-sshd> client # [2465565.752608] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-sshd> client # [2465565.756268] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-sshd> client # [2465565.762254] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-sshd> client # [2465565.762714] client systemd[1]: Starting Update is Completed... container-test-run-sshd> client # [2465565.767955] client systemd[1]: Finished Update is Completed. container-test-run-sshd> client # [2465565.792162] client systemd[1]: Finished Firewall. container-test-run-sshd> client # [2465565.792225] client systemd[1]: Reached target Preparation for Network. container-test-run-sshd> client # [2465565.792365] client systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-sshd> client # [2465565.792944] client systemd[1]: Starting Network Management... container-test-run-sshd> server # [2465565.705595] server systemd-journald[99]: Journal started container-test-run-sshd> server # [2465565.705627] server systemd-journald[99]: Runtime Journal (/run/log/journal/9df8f4ac502e45b0a6ed9b975790addb) is 8M, max 3.7G, 3.7G free. container-test-run-sshd> server # [2465565.709319] server systemd[1]: Finished Apply Kernel Variables. container-test-run-sshd> server # [2465565.715645] server systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-sshd> server # [2465565.725138] server systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-sshd> server # [2465565.725751] server systemd[1]: Starting Network Name Resolution... container-test-run-sshd> server # [2465565.726265] server systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-sshd> server # [2465565.730845] server systemd-journald[99]: Time spent on flushing to /var/log/journal/9df8f4ac502e45b0a6ed9b975790addb is 985us for 7 entries. container-test-run-sshd> server # [2465565.730845] server systemd-journald[99]: System Journal (/var/log/journal/9df8f4ac502e45b0a6ed9b975790addb) is 8M, max 4G, 3.9G free. container-test-run-sshd> server # [2465565.741844] server systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-sshd> server # [2465565.742045] server systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-sshd> server # [2465565.742929] server systemd[1]: Reached target Preparation for Local File Systems. container-test-run-sshd> server # [2465565.742979] server systemd[1]: Reached target Local File Systems. container-test-run-sshd> server # [2465565.743408] server systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-sshd> server # [2465565.743433] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> server # [2465565.743807] server systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-sshd> server # [2465565.744130] server systemd[1]: Starting Create System Files and Directories... container-test-run-sshd> server # [2465565.744144] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-sshd> server # [2465565.753979] server systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-sshd> server # [2465565.754467] server systemd-tmpfiles[159]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-sshd> server # [2465565.754611] server systemd-tmpfiles[159]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-sshd> server # [2465565.754709] server systemd-tmpfiles[159]: fchmod() of /var/log/journal/9df8f4ac502e45b0a6ed9b975790addb failed: Operation not permitted container-test-run-sshd> server # [2465565.754854] server systemd-tmpfiles[159]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-sshd> server # [2465565.755576] server systemd[1]: Finished Create System Files and Directories. container-test-run-sshd> server # [2465565.756007] server systemd[1]: Starting Rebuild Journal Catalog... container-test-run-sshd> server # [2465565.756305] server systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-sshd> server # [2465565.762346] server systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-sshd> server # [2465565.768496] server systemd[1]: Finished Rebuild Journal Catalog. container-test-run-sshd> server # [2465565.768998] server systemd[1]: Starting Update is Completed... container-test-run-sshd> server # [2465565.774867] server systemd[1]: Finished Update is Completed. container-test-run-sshd> server # [2465565.793375] server systemd[1]: Finished Firewall. container-test-run-sshd> server # [2465565.793442] server systemd[1]: Reached target Preparation for Network. container-test-run-sshd> server # [2465565.793572] server systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-sshd> server # [2465565.794079] server systemd[1]: Starting Network Management... container-test-run-sshd> server # [2465566.266186] server systemd-networkd[215]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-sshd> server # [2465566.266255] server systemd-networkd[215]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-sshd> server # [2465566.273910] server systemd-networkd[215]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-sshd> server # [2465566.274062] server systemd-networkd[215]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-sshd> server # [2465566.274132] server systemd-networkd[215]: lo: Link UP container-test-run-sshd> server # [2465566.274135] server systemd-networkd[215]: lo: Gained carrier container-test-run-sshd> server # [2465566.274262] server systemd-networkd[215]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-sshd> server # [2465566.274502] server systemd[1]: Started Network Management. container-test-run-sshd> server # [2465566.274529] server systemd-networkd[215]: eth1: Link UP container-test-run-sshd> server # [2465566.274665] server systemd-networkd[215]: eth1: Gained carrier container-test-run-sshd> server # [2465566.275137] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-sshd> server # [2465566.298048] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-sshd> client # [2465566.275951] client systemd-networkd[186]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-sshd> client # [2465566.276021] client systemd-networkd[186]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-sshd> client # [2465566.284137] client systemd-networkd[186]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-sshd> client # [2465566.284313] client systemd-networkd[186]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-sshd> client # [2465566.284404] client systemd-networkd[186]: lo: Link UP container-test-run-sshd> client # [2465566.284407] client systemd-networkd[186]: lo: Gained carrier container-test-run-sshd> client # [2465566.284577] client systemd-networkd[186]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-sshd> client # [2465566.284837] client systemd[1]: Started Network Management. container-test-run-sshd> client # [2465566.284890] client systemd-networkd[186]: eth1: Link UP container-test-run-sshd> client # [2465566.285022] client systemd-networkd[186]: eth1: Gained carrier container-test-run-sshd> client # [2465566.285450] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-sshd> client # [2465566.307299] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-sshd> server # [2465566.626597] server systemd-resolved[136]: Positive Trust Anchors: container-test-run-sshd> server # [2465566.626603] server systemd-resolved[136]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-sshd> server # [2465566.626607] server systemd-resolved[136]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-sshd> server # [2465566.626622] server systemd-resolved[136]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-sshd> server # [2465566.637275] server systemd-resolved[136]: Using system hostname 'server'. container-test-run-sshd> server # [2465566.638131] server systemd[1]: Started Network Name Resolution. container-test-run-sshd> server # [2465566.638181] server systemd[1]: Reached target Network. container-test-run-sshd> server # [2465566.638214] server systemd[1]: Reached target System Initialization. container-test-run-sshd> server # [2465566.638246] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> server # [2465566.638260] server systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-sshd> server # [2465566.638272] server systemd[1]: Reached target Timer Units. container-test-run-sshd> server # [2465566.638343] server systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-sshd> server # [2465566.638402] server systemd[1]: Listening on Nix Daemon Socket. container-test-run-sshd> server # [2465566.638975] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-sshd> server # [2465566.639488] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-sshd> server # [2465566.639752] server systemd[1]: Listening on SSH Socket. container-test-run-sshd> server # [2465566.639820] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-sshd> server # [2465566.639830] server systemd[1]: Reached target Socket Units. container-test-run-sshd> server # [2465566.639855] server systemd[1]: Reached target Basic System. container-test-run-sshd> server # [2465566.659535] server systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-sshd> server # [2465566.660178] server systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-sshd> server # [2465566.660195] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [2465566.661262] server systemd[1]: Starting D-Bus System Message Bus... container-test-run-sshd> server # [2465566.670014] server systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-sshd> server # [2465566.703254] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-sshd> server # [2465566.796639] server nsncd[221]: Oct 02 20:09:41.219 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-sshd> server # [2465566.796705] server systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-sshd> server # [2465566.796749] server systemd[1]: Reached target Host and Network Name Lookups. container-test-run-sshd> server # [2465566.796787] server systemd[1]: Reached target User and Group Name Lookups. container-test-run-sshd> server # [2465566.797579] server systemd[1]: Starting User Login Management... container-test-run-sshd> server # [2465566.798067] server systemd[1]: Starting Permit User Sessions... container-test-run-sshd> server # [2465566.804284] server systemd[1]: Finished Permit User Sessions. container-test-run-sshd> server # [2465566.804940] server systemd[1]: Started Console Getty. container-test-run-sshd> server # [2465566.804963] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-sshd> server # [2465566.804976] server systemd[1]: Reached target Login Prompts. container-test-run-sshd> server # [2465566.915387] server dbus-broker-launch[222]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-sshd> server # [2465566.915793] server dbus-broker-launch[222]: NSS returned no entry for 'systemd-timesync' container-test-run-sshd> server # [2465566.915793] server dbus-broker-launch[222]: Invalid user-name in /nix/store/c25bgyjjjf90dmjljarq2n1xvmrwp8lw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-sshd> client # [2465566.626050] client systemd-resolved[105]: Positive Trust Anchors: container-test-run-sshd> client # [2465566.626057] client systemd-resolved[105]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-sshd> client # [2465566.626060] client systemd-resolved[105]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-sshd> client # [2465566.626075] client systemd-resolved[105]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-sshd> client # [2465566.636575] client systemd-resolved[105]: Using system hostname 'client'. container-test-run-sshd> client # [2465566.637529] client systemd[1]: Started Network Name Resolution. container-test-run-sshd> client # [2465566.637587] client systemd[1]: Reached target Network. container-test-run-sshd> client # [2465566.637628] client systemd[1]: Reached target System Initialization. container-test-run-sshd> client # [2465566.637670] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> client # [2465566.637689] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-sshd> client # [2465566.637703] client systemd[1]: Reached target Timer Units. container-test-run-sshd> client # [2465566.637796] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-sshd> client # [2465566.637879] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-sshd> client # [2465566.637968] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-sshd> client # [2465566.637982] client systemd[1]: Reached target Socket Units. container-test-run-sshd> client # [2465566.638018] client systemd[1]: Reached target Basic System. container-test-run-sshd> client # [2465566.638912] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-sshd> client # [2465566.639546] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-sshd> client # [2465566.659535] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-sshd> client # [2465566.668292] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-sshd> client # [2465566.698255] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-sshd> client # [2465566.792109] client nsncd[192]: Oct 02 20:09:41.215 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-sshd> client # [2465566.792155] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-sshd> client # [2465566.792200] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-sshd> client # [2465566.792238] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-sshd> client # [2465566.792965] client systemd[1]: Starting User Login Management... container-test-run-sshd> client # [2465566.793464] client systemd[1]: Starting Permit User Sessions... container-test-run-sshd> client # [2465566.799786] client systemd[1]: Finished Permit User Sessions. container-test-run-sshd> client # [2465566.800264] client systemd[1]: Started Console Getty. container-test-run-sshd> client # [2465566.800282] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-sshd> client # [2465566.800294] client systemd[1]: Reached target Login Prompts. container-test-run-sshd> client # [2465566.937532] client dbus-broker-launch[193]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-sshd> client # [2465566.938051] client dbus-broker-launch[193]: NSS returned no entry for 'systemd-timesync' container-test-run-sshd> client # [2465566.938051] client dbus-broker-launch[193]: Invalid user-name in /nix/store/nhxdfrdgqmwv4wnzynb7hi7rlkis2jp0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-sshd> client # [2465566.938433] client systemd[1]: Started D-Bus System Message Bus. container-test-run-sshd> client # [2465566.941808] client dbus-broker-launch[193]: Ready container-test-run-sshd> server # [2465566.916037] server systemd[1]: Started D-Bus System Message Bus. container-test-run-sshd> server # [2465566.919491] server dbus-broker-launch[222]: Ready container-test-run-sshd> client # [2465567.367106] client systemd-logind[206]: New seat seat0. container-test-run-sshd> client # [2465567.367249] client systemd[1]: Started User Login Management. container-test-run-sshd> client # [2465567.368038] client systemd[1]: Starting linger-users.service... container-test-run-sshd> client # [2465567.395071] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-sshd> client # [2465567.395162] client systemd[1]: Finished linger-users.service. container-test-run-sshd> client # [2465567.395444] client systemd[1]: Reached target Multi-User System. container-test-run-sshd> client # [2465567.395555] client systemd[1]: Startup finished in 1.926s. container-test-run-sshd> client # [2465567.488089] client systemd-networkd[186]: eth1: Gained IPv6LL container-test-run-sshd> server # [2465567.394917] server systemd-logind[237]: New seat seat0. container-test-run-sshd> server # [2465567.395051] server systemd[1]: Started User Login Management. container-test-run-sshd> server # [2465567.396015] server systemd[1]: Starting linger-users.service... container-test-run-sshd> server # [2465567.401437] server systemd[1]: linger-users.service: Deactivated successfully. container-test-run-sshd> server # [2465567.401541] server systemd[1]: Finished linger-users.service. container-test-run-sshd> server # [2465567.401773] server systemd[1]: Reached target Multi-User System. container-test-run-sshd> server # [2465567.401868] server systemd[1]: Startup finished in 1.906s. container-test-run-sshd> server # [2465567.488076] server systemd-networkd[215]: eth1: Gained IPv6LL container-test-run-sshd> Connection to 127.0.0.1 22 port [tcp/ssh] succeeded! container-test-run-sshd> server: (finished: must succeed: /nix/store/z3kz5w81zc0jnc7vpnfq6p5rgai0j291-libressl-4.3.2-nc/bin/nc -z -v 127.0.0.1 22, in 2.64 seconds) container-test-run-sshd> server: must succeed: grep '^@cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts container-test-run-sshd> server: (finished: must succeed: grep '^@cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts, in 0.00 seconds) container-test-run-sshd> server: must succeed: grep '^localhost,server,server.clan ssh-ed25519 ' /etc/ssh/ssh_known_hosts container-test-run-sshd> server: (finished: must succeed: grep '^localhost,server,server.clan ssh-ed25519 ' /etc/ssh/ssh_known_hosts, in 0.00 seconds) container-test-run-sshd> client: must succeed: grep '^.cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts container-test-run-sshd> client: (finished: must succeed: grep '^.cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts, in 0.00 seconds) container-test-run-sshd> server: must succeed: grep 'test-key' /etc/ssh/authorized_keys.d/root container-test-run-sshd> server: (finished: must succeed: grep 'test-key' /etc/ssh/authorized_keys.d/root, in 0.00 seconds) container-test-run-sshd> client: must succeed: cp /nix/store/wiksrsbhvksa9njqxd2i7say2bcvibnn-test-key /tmp/test-key && chmod 600 /tmp/test-key container-test-run-sshd> client: (finished: must succeed: cp /nix/store/wiksrsbhvksa9njqxd2i7say2bcvibnn-test-key /tmp/test-key && chmod 600 /tmp/test-key, in 0.01 seconds) container-test-run-sshd> client: must succeed: ssh -o StrictHostKeyChecking=accept-new -i /tmp/test-key root@server 'echo SSH_SUCCESS' container-test-run-sshd> container-test-run-sshd> client: (finished: must succeed: ssh -o StrictHostKeyChecking=accept-new -i /tmp/test-key root@server 'echo SSH_SUCCESS', in 0.09 seconds) container-test-run-sshd> server: must succeed: grep 'root@server' /etc/ssh/authorized_keys.d/root container-test-run-sshd> server: (finished: must succeed: grep 'root@server' /etc/ssh/authorized_keys.d/root, in 0.00 seconds) container-test-run-sshd> client: must succeed: scp -i /tmp/test-key root@server:/run/secrets/per-machine/server/sshd-root-key/id_ed25519 /tmp/generated-key container-test-run-sshd> client: (finished: must succeed: scp -i /tmp/test-key root@server:/run/secrets/per-machine/server/sshd-root-key/id_ed25519 /tmp/generated-key, in 0.11 seconds) container-test-run-sshd> client: must succeed: chmod 600 /tmp/generated-key container-test-run-sshd> client: (finished: must succeed: chmod 600 /tmp/generated-key, in 0.00 seconds) container-test-run-sshd> client: must succeed: ssh -i /tmp/generated-key root@server 'echo GENERATED_KEY_SUCCESS' container-test-run-sshd> server # [2465567.847101] server systemd[1]: Created slice Slice /system/sshd. container-test-run-sshd> server # [2465567.847134] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [2465567.847512] server systemd[1]: Started SSH per-connection Daemon (127.0.0.1:32908). container-test-run-sshd> server # [2465567.877183] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [2465567.877580] server systemd[1]: Started SSH per-connection Daemon ([2001:db8:1::1]:47620). container-test-run-sshd> server # [2465567.882577] server sshd-session[252]: Connection closed by 127.0.0.1 port 32908 [preauth] container-test-run-sshd> server # [2465567.883019] server systemd[1]: sshd@0-4163-127.0.0.1:22-127.0.0.1:32908.service: Deactivated successfully. container-test-run-sshd> server # [2465567.945547] server sshd-session[257]: Accepted publickey for root from 2001:db8:1::1 port 47620 ssh2: ED25519 SHA256:o/QD6rB73sctZzyYRQeIJAuU+/iqP9mNNwIF4P4uLSc container-test-run-sshd> server # [2465567.955457] server sshd-session[264]: Received disconnect from 2001:db8:1::1 port 47620:11: disconnected by user container-test-run-sshd> server # [2465567.955547] server sshd-session[264]: Disconnected from user root 2001:db8:1::1 port 47620 container-test-run-sshd> server # [2465567.955994] server systemd[1]: sshd@1-102484-2001:db8:1::2:22-2001:db8:1::1:47620.service: Deactivated successfully. container-test-run-sshd> server # [2465567.966847] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [2465567.967268] server systemd[1]: Started SSH per-connection Daemon ([2001:db8:1::1]:47630). container-test-run-sshd> server # [2465568.054603] server sshd-session[268]: Accepted publickey for root from 2001:db8:1::1 port 47630 ssh2: ED25519 SHA256:o/QD6rB73sctZzyYRQeIJAuU+/iqP9mNNwIF4P4uLSc container-test-run-sshd> server # [2465568.068379] server sshd-session[272]: Received disconnect from 2001:db8:1::1 port 47630:11: disconnected by user container-test-run-sshd> server # [2465568.068494] server sshd-session[272]: Disconnected from user root 2001:db8:1::1 port 47630 container-test-run-sshd> server # [2465568.069176] server systemd[1]: sshd@2-110873-2001:db8:1::2:22-2001:db8:1::1:47630.service: Deactivated successfully. container-test-run-sshd> server # [2465568.078346] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [2465568.078729] server systemd[1]: Started SSH per-connection Daemon ([2001:db8:1::1]:47644). container-test-run-sshd> client: (finished: must succeed: ssh -i /tmp/generated-key root@server 'echo GENERATED_KEY_SUCCESS', in 0.10 seconds) container-test-run-sshd> (finished: run the VM test script, in 2.97 seconds) container-test-run-sshd> test script finished in 3.21s container-test-run-sshd> cleanup container-test-run-sshd> kill NspawnMachine (pid 52) container-test-run-sshd> kill NspawnMachine (pid 53) container-test-run-sshd> server # [2465568.166457] server sshd-session[275]: Accepted publickey for root from 2001:db8:1::1 port 47644 ssh2: ED25519 SHA256:sZ4nNwowdc8HOu5lgnYDGmCyIW1poBypRnHk41aDNEM container-test-run-sshd> server # [2465568.176477] server sshd-session[279]: Received disconnect from 2001:db8:1::1 port 47644:11: disconnected by user container-test-run-sshd> server # [2465568.176590] server sshd-session[279]: Disconnected from user root 2001:db8:1::1 port 47644 container-test-run-sshd> server # [2465568.177166] server systemd[1]: sshd@3-49267-2001:db8:1::2:22-2001:db8:1::1:47644.service: Deactivated successfully. container-test-run-sshd> Container client terminated by signal KILL. container-test-run-sshd> Container server terminated by signal KILL. container-test-run-sshd> (finished: cleanup, in 0.18 seconds)