these 12 derivations will be built:
  /nix/store/kdjw4n5abwkfnkzixy711pwfr2r4xk6r-etc.drv
  /nix/store/b4xrav1ijsk6wzhyna13b6mm188s117q-activate.drv
  /nix/store/2q5d7fbcsny4377d4pnjscav523bzm07-nixos-system-server-test.drv
  /nix/store/7g738q7dia4qpm914rm4n4iss15ixa84-etc.drv
  /nix/store/7s29yzx5dbdwfibwn54lx5aq5cwkcslm-run-server-nspawn.drv
  /nix/store/dwkb5yjg136a24wsx0jynfsrdpz8p19h-nixos-test-driver-1.1.drv
  /nix/store/k75p7rwvq9g7lrmdhxdjdyhal9wl58mm-activate.drv
  /nix/store/rhr9wjqjc3qqp7hxwg0bam0awcmncpw4-nixos-system-client-test.drv
  /nix/store/ny8gkrpi13xhrhayyd4h128d0si9iqw4-run-client-nspawn.drv
  /nix/store/n19y825lf3vkrq0l19lqxcajgxiff998-driverConfiguration.json.drv
  /nix/store/v7wan27cnjz1wxz6py3lc31sylgdzsri-nixos-test-driver-sshd.drv
  /nix/store/ckb4nm0yzibmfxapzrb5x6fgki10bkfb-container-test-run-sshd.drv
building '/nix/store/7g738q7dia4qpm914rm4n4iss15ixa84-etc.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/kdjw4n5abwkfnkzixy711pwfr2r4xk6r-etc.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/kdjw4n5abwkfnkzixy711pwfr2r4xk6r-etc.drv'
building '/nix/store/b4xrav1ijsk6wzhyna13b6mm188s117q-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/7g738q7dia4qpm914rm4n4iss15ixa84-etc.drv'
building '/nix/store/k75p7rwvq9g7lrmdhxdjdyhal9wl58mm-activate.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/b4xrav1ijsk6wzhyna13b6mm188s117q-activate.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/k75p7rwvq9g7lrmdhxdjdyhal9wl58mm-activate.drv'
building '/nix/store/rhr9wjqjc3qqp7hxwg0bam0awcmncpw4-nixos-system-client-test.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/2q5d7fbcsny4377d4pnjscav523bzm07-nixos-system-server-test.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/rhr9wjqjc3qqp7hxwg0bam0awcmncpw4-nixos-system-client-test.drv'
nixos-system-client-test> structuredAttrs is enabled
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/ny8gkrpi13xhrhayyd4h128d0si9iqw4-run-client-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/2q5d7fbcsny4377d4pnjscav523bzm07-nixos-system-server-test.drv'
nixos-system-server-test> structuredAttrs is enabled
building '/nix/store/7s29yzx5dbdwfibwn54lx5aq5cwkcslm-run-server-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/ny8gkrpi13xhrhayyd4h128d0si9iqw4-run-client-nspawn.drv'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/7s29yzx5dbdwfibwn54lx5aq5cwkcslm-run-server-nspawn.drv'
building '/nix/store/n19y825lf3vkrq0l19lqxcajgxiff998-driverConfiguration.json.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/n19y825lf3vkrq0l19lqxcajgxiff998-driverConfiguration.json.drv'
driverConfiguration.json> structuredAttrs is enabled
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/v7wan27cnjz1wxz6py3lc31sylgdzsri-nixos-test-driver-sshd.drv' on 'ssh-ng://builder@build01.clan.lol'
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/v7wan27cnjz1wxz6py3lc31sylgdzsri-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!
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy
building '/nix/store/ckb4nm0yzibmfxapzrb5x6fgki10bkfb-container-test-run-sshd.drv' on 'ssh-ng://builder@build01.clan.lol'
building '/nix/store/ckb4nm0yzibmfxapzrb5x6fgki10bkfb-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 "<string>", 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 "<string>", line 13
container-test-run-sshd> start all VMs
container-test-run-sshd> server: systemd-nspawn running (pid 53)
container-test-run-sshd> client: systemd-nspawn running (pid 52)
container-test-run-sshd> server: Waiting for journal at /build/vm-state-server/var/log/journal...
container-test-run-sshd> client: Waiting for journal at /build/vm-state-client/var/log/journal...
container-test-run-sshd> (finished: start all VMs, in 0.00 seconds)
container-test-run-sshd> server: must succeed: /nix/store/8hi0l1vk71jspcixgjspchz6x21wnsr7-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> server # [7072950.034074] server systemd-journald[77]: Journal started
container-test-run-sshd> server # [7072950.034121] server systemd-journald[77]: Runtime Journal (/run/log/journal/584aa1d60eaf4e9bacc700a088f28974) is 8M, max 2.5G, 2.4G free.
container-test-run-sshd> server # [7072950.036432] server systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-sshd> server # [7072950.044337] server systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-sshd> server # [7072950.045061] server systemd[1]: Starting Network Name Resolution...
container-test-run-sshd> server # [7072950.045876] server systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-sshd> server # [7072950.052145] server systemd-journald[77]: Time spent on flushing to /var/log/journal/584aa1d60eaf4e9bacc700a088f28974 is 1.178ms for 6 entries.
container-test-run-sshd> server # [7072950.052145] server systemd-journald[77]: System Journal (/var/log/journal/584aa1d60eaf4e9bacc700a088f28974) is 8M, max 4G, 3.9G free.
container-test-run-sshd> server # [7072950.060417] server systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-sshd> server # [7072950.061044] server systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-sshd> server # [7072950.061165] server systemd[1]: Reached target Local File Systems.
container-test-run-sshd> server # [7072950.061955] server systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-sshd> server # [7072950.062000] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-sshd> server # [7072950.062792] server systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-sshd> server # [7072950.062825] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-sshd> server # [7072950.072505] server systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-sshd> server # [7072950.074048] server systemd[1]: Starting Create System Files and Directories...
container-test-run-sshd> server # [7072950.092584] server systemd-tmpfiles[121]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-sshd> server # [7072950.092757] server systemd-tmpfiles[121]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-sshd> server # [7072950.092873] server systemd-tmpfiles[121]: fchmod() of /var/log/journal/584aa1d60eaf4e9bacc700a088f28974 failed: Operation not permitted
container-test-run-sshd> server # [7072950.093048] server systemd-tmpfiles[121]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-sshd> server # [7072950.094385] server systemd[1]: Finished Create System Files and Directories.
container-test-run-sshd> server # [7072950.095583] server systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-sshd> server # [7072950.096336] server systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-sshd> server # [7072950.108466] server systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-sshd> client # [7072950.026885] client systemd-journald[69]: Journal started
container-test-run-sshd> client # [7072950.026941] client systemd-journald[69]: Runtime Journal (/run/log/journal/27eca5b6545a47f5bd02ab30329e565a) is 8M, max 2.5G, 2.4G free.
container-test-run-sshd> client # [7072950.031563] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-sshd> client # [7072950.040830] client systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-sshd> client # [7072950.041700] client systemd[1]: Starting Network Name Resolution...
container-test-run-sshd> client # [7072950.042388] client systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-sshd> client # [7072950.051985] client systemd-journald[69]: Time spent on flushing to /var/log/journal/27eca5b6545a47f5bd02ab30329e565a is 1.468ms for 6 entries.
container-test-run-sshd> client # [7072950.051985] client systemd-journald[69]: System Journal (/var/log/journal/27eca5b6545a47f5bd02ab30329e565a) is 8M, max 4G, 3.9G free.
container-test-run-sshd> client # [7072950.058225] client systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-sshd> client # [7072950.058459] client systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-sshd> client # [7072950.058545] client systemd[1]: Reached target Local File Systems.
container-test-run-sshd> client # [7072950.059274] client systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-sshd> client # [7072950.059315] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-sshd> client # [7072950.060191] client systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-sshd> client # [7072950.060228] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-sshd> client # [7072950.073152] client systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-sshd> client # [7072950.074756] client systemd[1]: Starting Create System Files and Directories...
container-test-run-sshd> client # [7072950.094366] client systemd-tmpfiles[115]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-sshd> client # [7072950.094530] client systemd-tmpfiles[115]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-sshd> client # [7072950.094647] client systemd-tmpfiles[115]: fchmod() of /var/log/journal/27eca5b6545a47f5bd02ab30329e565a failed: Operation not permitted
container-test-run-sshd> client # [7072950.094816] client systemd-tmpfiles[115]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-sshd> client # [7072950.095806] client systemd[1]: Finished Create System Files and Directories.
container-test-run-sshd> client # [7072950.097300] client systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-sshd> client # [7072950.097942] client systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-sshd> client # [7072950.112876] client systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-sshd> client # [7072950.118419] client systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-sshd> client # [7072950.119757] client systemd[1]: Starting Update is Completed...
container-test-run-sshd> client # [7072950.130892] client systemd[1]: Finished Update is Completed.
container-test-run-sshd> client # [7072950.182959] client systemd[1]: Finished Firewall.
container-test-run-sshd> client # [7072950.183104] client systemd[1]: Reached target Preparation for Network.
container-test-run-sshd> client # [7072950.183326] client systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-sshd> client # [7072950.184385] client systemd[1]: Starting Network Management...
container-test-run-sshd> server # [7072950.118653] server systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-sshd> server # [7072950.119668] server systemd[1]: Starting Update is Completed...
container-test-run-sshd> server # [7072950.129864] server systemd[1]: Finished Update is Completed.
container-test-run-sshd> server # [7072950.187442] server systemd[1]: Finished Firewall.
container-test-run-sshd> server # [7072950.187599] server systemd[1]: Reached target Preparation for Network.
container-test-run-sshd> server # [7072950.187825] server systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-sshd> server # [7072950.188852] server systemd[1]: Starting Network Management...
container-test-run-sshd> server # [7072950.624998] server systemd-networkd[192]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-sshd> server # [7072950.625085] server systemd-networkd[192]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-sshd> server # [7072950.631454] server systemd-networkd[192]: /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 # [7072950.631619] server systemd-networkd[192]: /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 # [7072950.631769] server systemd-networkd[192]: lo: Link UP
container-test-run-sshd> server # [7072950.631772] server systemd-networkd[192]: lo: Gained carrier
container-test-run-sshd> server # [7072950.631939] server systemd-networkd[192]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-sshd> server # [7072950.632331] server systemd[1]: Started Network Management.
container-test-run-sshd> server # [7072950.632403] server systemd-networkd[192]: eth1: Link UP
container-test-run-sshd> server # [7072950.632727] server systemd-networkd[192]: eth1: Gained carrier
container-test-run-sshd> server # [7072950.633351] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-sshd> server # [7072950.673932] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-sshd> server # [7072950.694263] server systemd-resolved[99]: Positive Trust Anchors:
container-test-run-sshd> server # [7072950.694275] server systemd-resolved[99]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-sshd> server # [7072950.694279] server systemd-resolved[99]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-sshd> server # [7072950.694314] server systemd-resolved[99]: 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 # [7072950.717204] server systemd-resolved[99]: Using system hostname 'server'.
container-test-run-sshd> server # [7072950.718576] server systemd[1]: Started Network Name Resolution.
container-test-run-sshd> server # [7072950.718650] server systemd[1]: Reached target Network.
container-test-run-sshd> server # [7072950.718714] server systemd[1]: Reached target System Initialization.
container-test-run-sshd> server # [7072950.718759] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-sshd> server # [7072950.718785] server systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-sshd> server # [7072950.718803] server systemd[1]: Reached target Timer Units.
container-test-run-sshd> server # [7072950.718917] server systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-sshd> server # [7072950.719030] server systemd[1]: Listening on Nix Daemon Socket.
container-test-run-sshd> server # [7072950.719998] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export).
container-test-run-sshd> server # [7072950.720920] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
container-test-run-sshd> server # [7072950.721373] server systemd[1]: Listening on SSH Socket.
container-test-run-sshd> server # [7072950.721474] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-sshd> server # [7072950.721497] server systemd[1]: Reached target Socket Units.
container-test-run-sshd> server # [7072950.721543] server systemd[1]: Reached target Basic System.
container-test-run-sshd> server # [7072950.722788] server systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-sshd> server # [7072950.723721] server systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-sshd> server # [7072950.723745] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
container-test-run-sshd> server # [7072950.725369] server systemd[1]: Starting D-Bus System Message Bus...
container-test-run-sshd> server # [7072950.744808] server systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-sshd> server # [7072950.827170] server nsncd[198]: Aug 29 20:06:16.880 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-sshd> server # [7072950.827257] server systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-sshd> server # [7072950.827309] server systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-sshd> server # [7072950.827364] server systemd[1]: Reached target User and Group Name Lookups.
container-test-run-sshd> server # [7072950.828452] server systemd[1]: Starting User Login Management...
container-test-run-sshd> server # [7072950.876348] server systemd[1]: Starting Permit User Sessions...
container-test-run-sshd> client # [7072950.616563] client systemd-networkd[182]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-sshd> client # [7072950.616653] client systemd-networkd[182]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-sshd> client # [7072950.623067] client systemd-networkd[182]: /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 # [7072950.623231] client systemd-networkd[182]: /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 # [7072950.623386] client systemd-networkd[182]: lo: Link UP
container-test-run-sshd> client # [7072950.623391] client systemd-networkd[182]: lo: Gained carrier
container-test-run-sshd> client # [7072950.623559] client systemd-networkd[182]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-sshd> client # [7072950.623914] client systemd[1]: Started Network Management.
container-test-run-sshd> client # [7072950.625309] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-sshd> client # [7072950.625534] client systemd-networkd[182]: eth1: Link UP
container-test-run-sshd> client # [7072950.625763] client systemd-networkd[182]: eth1: Gained carrier
container-test-run-sshd> client # [7072950.673950] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-sshd> client # [7072950.710664] client systemd-resolved[91]: Positive Trust Anchors:
container-test-run-sshd> client # [7072950.710678] client systemd-resolved[91]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-sshd> client # [7072950.710680] client systemd-resolved[91]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-sshd> client # [7072950.710715] client systemd-resolved[91]: 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 # [7072950.733364] client systemd-resolved[91]: Using system hostname 'client'.
container-test-run-sshd> client # [7072950.734741] client systemd[1]: Started Network Name Resolution.
container-test-run-sshd> client # [7072950.734829] client systemd[1]: Reached target Network.
container-test-run-sshd> client # [7072950.734893] client systemd[1]: Reached target System Initialization.
container-test-run-sshd> client # [7072950.734941] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-sshd> client # [7072950.734964] client systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-sshd> client # [7072950.734981] client systemd[1]: Reached target Timer Units.
container-test-run-sshd> client # [7072950.735101] client systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-sshd> client # [7072950.735222] client systemd[1]: Listening on Nix Daemon Socket.
container-test-run-sshd> client # [7072950.735326] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-sshd> client # [7072950.735347] client systemd[1]: Reached target Socket Units.
container-test-run-sshd> client # [7072950.735377] client systemd[1]: Reached target Basic System.
container-test-run-sshd> client # [7072950.736511] client systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-sshd> client # [7072950.737283] client systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-sshd> client # [7072950.738365] client systemd[1]: Starting D-Bus System Message Bus...
container-test-run-sshd> client # [7072950.754882] client systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-sshd> client # [7072950.822533] client systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-sshd> client # [7072950.822743] client nsncd[188]: Aug 29 20:06:16.875 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-sshd> client # [7072950.822595] client systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-sshd> client # [7072950.822655] client systemd[1]: Reached target User and Group Name Lookups.
container-test-run-sshd> client # [7072950.824673] client systemd[1]: Starting User Login Management...
container-test-run-sshd> client # [7072950.825359] client systemd[1]: Starting Permit User Sessions...
container-test-run-sshd> server # [7072950.886474] server systemd[1]: Finished Permit User Sessions.
container-test-run-sshd> server # [7072950.887371] server systemd[1]: Started Console Getty.
container-test-run-sshd> server # [7072950.887408] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-sshd> server # [7072950.887425] server systemd[1]: Reached target Login Prompts.
container-test-run-sshd> server # [7072950.893133] server dbus-broker-launch[199]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-sshd> server # [7072950.894169] server dbus-broker-launch[199]: NSS returned no entry for 'systemd-timesync'
container-test-run-sshd> server # [7072950.894202] server dbus-broker-launch[199]: Invalid user-name in /nix/store/jdav0pgid835bimky4j3wgb0xl8sb2zh-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-sshd> server # [7072950.894684] server systemd[1]: Started D-Bus System Message Bus.
container-test-run-sshd> server # [7072950.899216] server systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-sshd> server # [7072950.901473] server dbus-broker-launch[199]: Ready
container-test-run-sshd> server # [7072951.021766] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-sshd> client # [7072950.882317] client systemd[1]: Finished Permit User Sessions.
container-test-run-sshd> client # [7072950.883322] client systemd[1]: Started Console Getty.
container-test-run-sshd> client # [7072950.883358] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-sshd> client # [7072950.883378] client systemd[1]: Reached target Login Prompts.
container-test-run-sshd> client # [7072950.898858] client systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-sshd> client # [7072950.910591] client dbus-broker-launch[189]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-sshd> client # [7072950.911387] client dbus-broker-launch[189]: NSS returned no entry for 'systemd-timesync'
container-test-run-sshd> client # [7072950.911387] client dbus-broker-launch[189]: Invalid user-name in /nix/store/4vgxxm5pm041xfw8cndff8xyj1921rvv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-sshd> client # [7072950.911748] client systemd[1]: Started D-Bus System Message Bus.
container-test-run-sshd> client # [7072950.918936] client dbus-broker-launch[189]: Ready
container-test-run-sshd> client # [7072951.013037] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
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/8hi0l1vk71jspcixgjspchz6x21wnsr7-libressl-4.3.2-nc/bin/nc -z -v 127.0.0.1 22, in 2.64 seconds)
container-test-run-sshd> server # [7072951.390001] server systemd-logind[214]: New seat seat0.
container-test-run-sshd> server: must fail: grep '^@cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts
container-test-run-sshd> server # [7072951.390386] server systemd[1]: Started User Login Management.
container-test-run-sshd> client # [7072951.390001] client systemd-logind[204]: New seat seat0.
container-test-run-sshd> server # [7072951.393346] server systemd[1]: Starting linger-users.service...
container-test-run-sshd> client # [7072951.390206] client systemd[1]: Started User Login Management.
container-test-run-sshd> server # [7072951.403152] server systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-sshd> client # [7072951.391716] client systemd[1]: Starting linger-users.service...
container-test-run-sshd> server # [7072951.403237] server systemd[1]: Finished linger-users.service.
container-test-run-sshd> client # [7072951.402822] client systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-sshd> server # [7072951.403641] server systemd[1]: Reached target Multi-User System.
container-test-run-sshd> client # [7072951.403032] client systemd[1]: Finished linger-users.service.
container-test-run-sshd> server # [7072951.403846] server systemd[1]: Startup finished in 1.788s.
container-test-run-sshd> client # [7072951.403445] client systemd[1]: Reached target Multi-User System.
container-test-run-sshd> server # [7072951.750820] server systemd[1]: Created slice Slice /system/sshd.
container-test-run-sshd> client # [7072951.403806] client systemd[1]: Startup finished in 1.804s.
container-test-run-sshd> server # [7072951.750888] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
container-test-run-sshd> server: (finished: must fail: grep '^@cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts, in 0.01 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.01 seconds)
container-test-run-sshd> client: must fail: grep '^.cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts
container-test-run-sshd> client: (finished: must fail: grep '^.cert-authority ssh-ca,\*.clan,\*.example.com ssh-ed25519 ' /etc/ssh/ssh_known_hosts, in 0.01 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.01 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.15 seconds)
container-test-run-sshd> (finished: run the VM test script, in 2.84 seconds)
container-test-run-sshd> test script finished in 3.01s
container-test-run-sshd> cleanup
container-test-run-sshd> kill NspawnMachine (pid 52)
container-test-run-sshd> server # [7072951.751727] server systemd[1]: Started SSH per-connection Daemon (127.0.0.1:54416).
container-test-run-sshd> server # [7072951.775168] server sshd-session[230]: Connection closed by 127.0.0.1 port 54416 [preauth]
container-test-run-sshd> server # [7072951.776280] server systemd[1]: sshd@0-90192-127.0.0.1:22-127.0.0.1:54416.service: Deactivated successfully.
container-test-run-sshd> server # [7072951.814120] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.
container-test-run-sshd> server # [7072951.815186] server systemd[1]: Started SSH per-connection Daemon (192.168.1.1:50376).
container-test-run-sshd> server # [7072951.936450] server sshd-session[238]: Accepted publickey for root from 192.168.1.1 port 50376 ssh2: ED25519 SHA256:o/QD6rB73sctZzyYRQeIJAuU+/iqP9mNNwIF4P4uLSc
container-test-run-sshd> server # [7072951.949672] server sshd-session[242]: Received disconnect from 192.168.1.1 port 50376:11: disconnected by user
container-test-run-sshd> server # [7072951.949845] server sshd-session[242]: Disconnected from user root 192.168.1.1 port 50376
container-test-run-sshd> server # [7072951.950974] server systemd[1]: sshd@1-73791-192.168.1.2:22-192.168.1.1:50376.service: Deactivated successfully.
container-test-run-sshd> kill NspawnMachine (pid 53)
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.45 seconds)
warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy

post-build step Upload to niks3: ok
time=2026-08-29T20:06:21.977Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)"
time=2026-08-29T20:06:22.175Z level=INFO msg="Uploading 1 narinfos"
time=2026-08-29T20:06:22.288Z level=INFO msg="Upload complete. (384ms)"