these 34 derivations will be built: /nix/store/kx6rnbfyzb00y0hrp7jgcq2apifsm6f6-system-path.drv /nix/store/nk82zas2l43k06jn070jfa2i82c9p383-dbus-1.drv /nix/store/9ds21did6xw7wzx8953kwmlrnp04chjg-X-Restart-Triggers-dbus-broker.drv /nix/store/02k350vyhhdy753lccrf992w7dv08fwc-unit-dbus-broker.service.drv /nix/store/2lvinps3r59qb6ar5yac060h39bbvx1a-user-units.drv /nix/store/lmmf6h3zqnvaj0jfpps6nqmd90r22aws-extra-hosts.drv /nix/store/32p0wf2fm56fl6cjdfvb0v0am0vzdw9v-hosts.drv /nix/store/3lx5lrcj8mqdhy2bi0i9y2wr0c0qccsl-vars-check-sshd.drv /nix/store/mlr6hpsnyh2d5143w1snivjbwmhsarb0-system-units.drv /nix/store/92431d6ai8yy2jf397qf5f1dlwjl1y9g-etc.drv /nix/store/9dmrkw4acxrjqh3hqlin5x2713y0d4pm-activate.drv /nix/store/55pr804rrn9zx1lj6jxjhxzqww0fnjc3-nixos-system-client-test.drv /nix/store/61pp8hc9xrjn2ni60378rpr34mmqgm9n-user-units.drv /nix/store/9mxyxicdxdjvxs78ygrgsax35za46i3m-sshd.conf-settings.drv /nix/store/7nl6kya88qcz6jnwpkx0nlmrw8qkn6aw-sshd.conf-final.drv /nix/store/96afqkccd9089dxg0hrynv4h11nbaljj-decrypt-age-secrets.drv /nix/store/b038rwij4kjk2dqv934c058jyjd6jz98-unit-dbus-broker.service.drv /nix/store/dld8gch47mhq7jl9bjnwqxb1h2aigk6c-etc-ssh-ssh_known_hosts.drv /nix/store/vqdcqmvcil32kh6jb881935v0960x4xm-root-authorized_keys.drv /nix/store/w7an5k71r169qnsjc1amckawmfjv7gxk-hosts.drv /nix/store/kiv85ds3bg3gfznwynv40z4jvgj879m3-unit-script-sshd-keygen-start.drv /nix/store/x3bimq68fcv912iaf3hnb996f1362blq-unit-sshd-keygen.service.drv /nix/store/zvs2ccllr3h7bkrpwkylpdbl0b8cfk5r-system-units.drv /nix/store/gdrag6hj0rnc5fs98f1ifcn357agwlas-etc.drv /nix/store/c3fnmq3iqs1xr36ldbc2jksfsdx8fi64-activate.drv /nix/store/d0sm8rhph7mz1v16zdmfqr576gry2cab-run-client-nspawn.drv /nix/store/fzdnbcr7mg6900j2j69fws01qn205npp-dry-activate.drv /nix/store/x6cm25v94l4kflrwqcvy8i0m29m019cl-check-sshd-config.drv /nix/store/dnlganwnqwsjjycz8zp815fdf61m5fqq-nixos-system-server-test.drv /nix/store/dj795x33zvjgcmjrp8149zb4y3jcw3v8-run-server-nspawn.drv /nix/store/njmvfxas2zjv5ym95iia49sim8x6ifaa-test-script.drv /nix/store/j11b116rq9fv03vk6xrhikdj3jhmclf8-driverConfiguration.json.drv /nix/store/c4sww0iyzkjs4n14v9yk7d9qjbddyyr6-nixos-test-driver-sshd.drv /nix/store/kyg2vzh9zyy2rl1hn90cpaa7jypv5p2k-container-test-run-sshd.drv building '/nix/store/96afqkccd9089dxg0hrynv4h11nbaljj-decrypt-age-secrets.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/dld8gch47mhq7jl9bjnwqxb1h2aigk6c-etc-ssh-ssh_known_hosts.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/vqdcqmvcil32kh6jb881935v0960x4xm-root-authorized_keys.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/9mxyxicdxdjvxs78ygrgsax35za46i3m-sshd.conf-settings.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/njmvfxas2zjv5ym95iia49sim8x6ifaa-test-script.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/96afqkccd9089dxg0hrynv4h11nbaljj-decrypt-age-secrets.drv' building '/nix/store/fzdnbcr7mg6900j2j69fws01qn205npp-dry-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/dld8gch47mhq7jl9bjnwqxb1h2aigk6c-etc-ssh-ssh_known_hosts.drv' building '/nix/store/vqdcqmvcil32kh6jb881935v0960x4xm-root-authorized_keys.drv' building '/nix/store/9mxyxicdxdjvxs78ygrgsax35za46i3m-sshd.conf-settings.drv' building '/nix/store/7nl6kya88qcz6jnwpkx0nlmrw8qkn6aw-sshd.conf-final.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/njmvfxas2zjv5ym95iia49sim8x6ifaa-test-script.drv' building '/nix/store/92431d6ai8yy2jf397qf5f1dlwjl1y9g-etc.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/fzdnbcr7mg6900j2j69fws01qn205npp-dry-activate.drv' building '/nix/store/7nl6kya88qcz6jnwpkx0nlmrw8qkn6aw-sshd.conf-final.drv' building '/nix/store/x6cm25v94l4kflrwqcvy8i0m29m019cl-check-sshd-config.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/92431d6ai8yy2jf397qf5f1dlwjl1y9g-etc.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/zvs2ccllr3h7bkrpwkylpdbl0b8cfk5r-system-units.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/x6cm25v94l4kflrwqcvy8i0m29m019cl-check-sshd-config.drv' building '/nix/store/9dmrkw4acxrjqh3hqlin5x2713y0d4pm-activate.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/zvs2ccllr3h7bkrpwkylpdbl0b8cfk5r-system-units.drv' building '/nix/store/gdrag6hj0rnc5fs98f1ifcn357agwlas-etc.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/9dmrkw4acxrjqh3hqlin5x2713y0d4pm-activate.drv' building '/nix/store/55pr804rrn9zx1lj6jxjhxzqww0fnjc3-nixos-system-client-test.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/gdrag6hj0rnc5fs98f1ifcn357agwlas-etc.drv' building '/nix/store/55pr804rrn9zx1lj6jxjhxzqww0fnjc3-nixos-system-client-test.drv' nixos-system-client-test> structuredAttrs is enabled building '/nix/store/d0sm8rhph7mz1v16zdmfqr576gry2cab-run-client-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol' building '/nix/store/c3fnmq3iqs1xr36ldbc2jksfsdx8fi64-activate.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/d0sm8rhph7mz1v16zdmfqr576gry2cab-run-client-nspawn.drv' building '/nix/store/c3fnmq3iqs1xr36ldbc2jksfsdx8fi64-activate.drv' 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/dnlganwnqwsjjycz8zp815fdf61m5fqq-nixos-system-server-test.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/dnlganwnqwsjjycz8zp815fdf61m5fqq-nixos-system-server-test.drv' nixos-system-server-test> structuredAttrs is enabled warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/dj795x33zvjgcmjrp8149zb4y3jcw3v8-run-server-nspawn.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/dj795x33zvjgcmjrp8149zb4y3jcw3v8-run-server-nspawn.drv' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/j11b116rq9fv03vk6xrhikdj3jhmclf8-driverConfiguration.json.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/j11b116rq9fv03vk6xrhikdj3jhmclf8-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/c4sww0iyzkjs4n14v9yk7d9qjbddyyr6-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/c4sww0iyzkjs4n14v9yk7d9qjbddyyr6-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/kyg2vzh9zyy2rl1hn90cpaa7jypv5p2k-container-test-run-sshd.drv' on 'ssh-ng://builder@build01.clan.lol' warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy building '/nix/store/kyg2vzh9zyy2rl1hn90cpaa7jypv5p2k-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> server: systemd-nspawn running (pid 53) container-test-run-sshd> client: Waiting for journal at /build/vm-state-client/var/log/journal... 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/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> client # No journal boot entry found for the specified boot (+0). container-test-run-sshd> server # [423635.754449] server systemd-journald[78]: Journal started container-test-run-sshd> server # [423635.754515] server systemd-journald[78]: Runtime Journal (/run/log/journal/b82d9bc24d4e4cba86b4fd0ba542b1b2) is 8M, max 2.5G, 2.4G free. container-test-run-sshd> server # [423635.761065] server systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-sshd> server # [423635.761887] server systemd[1]: Starting Network Name Resolution... container-test-run-sshd> server # [423635.762676] server systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-sshd> server # [423635.771825] server systemd-journald[78]: Time spent on flushing to /var/log/journal/b82d9bc24d4e4cba86b4fd0ba542b1b2 is 1.672ms for 5 entries. container-test-run-sshd> server # [423635.771825] server systemd-journald[78]: System Journal (/var/log/journal/b82d9bc24d4e4cba86b4fd0ba542b1b2) is 8M, max 4G, 3.9G free. container-test-run-sshd> server # [423635.777949] server systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-sshd> server # [423635.778226] server systemd[1]: Reached target Preparation for Local File Systems. container-test-run-sshd> server # [423635.778330] server systemd[1]: Reached target Local File Systems. container-test-run-sshd> server # [423635.779199] server systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-sshd> server # [423635.779248] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> server # [423635.780295] server systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-sshd> server # [423635.780346] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-sshd> server # [423635.817392] server systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-sshd> server # [423635.819729] server systemd[1]: Starting Create System Files and Directories... container-test-run-sshd> server # [423635.839847] server systemd-tmpfiles[132]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-sshd> server # [423635.840276] server systemd-tmpfiles[132]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-sshd> server # [423635.840458] server systemd-tmpfiles[132]: fchmod() of /var/log/journal/b82d9bc24d4e4cba86b4fd0ba542b1b2 failed: Operation not permitted container-test-run-sshd> server # [423635.840696] server systemd-tmpfiles[132]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-sshd> server # [423635.842249] server systemd[1]: Finished Create System Files and Directories. container-test-run-sshd> server # [423635.842563] server systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-sshd> server # [423635.844241] server systemd[1]: Starting Rebuild Journal Catalog... container-test-run-sshd> server # [423635.845190] server systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-sshd> server # [423635.859115] server systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-sshd> server # [423635.865387] server systemd[1]: Finished Rebuild Journal Catalog. container-test-run-sshd> server # [423635.866395] server systemd[1]: Starting Update is Completed... container-test-run-sshd> server # [423635.878121] server systemd[1]: Finished Update is Completed. container-test-run-sshd> server # [423635.968248] server systemd[1]: Finished Firewall. container-test-run-sshd> server # [423635.968479] server systemd[1]: Reached target Preparation for Network. container-test-run-sshd> server # [423635.968738] server systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-sshd> server # [423635.969903] server systemd[1]: Starting Network Management... container-test-run-sshd> server # [423636.330760] server systemd-networkd[194]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-sshd> server # [423636.330860] server systemd-networkd[194]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-sshd> server # [423636.339295] server systemd-networkd[194]: /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 # [423636.339694] server systemd-networkd[194]: /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 # [423636.339850] server systemd-networkd[194]: lo: Link UP container-test-run-sshd> server # [423636.339855] server systemd-networkd[194]: lo: Gained carrier container-test-run-sshd> server # [423636.340064] server systemd-networkd[194]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-sshd> server # [423636.340511] server systemd[1]: Started Network Management. container-test-run-sshd> server # [423636.344422] server systemd-networkd[194]: eth1: Link UP container-test-run-sshd> server # [423636.344734] server systemd-networkd[194]: eth1: Gained carrier container-test-run-sshd> server # [423636.345207] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-sshd> server # [423636.369570] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-sshd> server # [423636.393439] server systemd-resolved[98]: Positive Trust Anchors: container-test-run-sshd> server # [423636.393451] server systemd-resolved[98]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-sshd> server # [423636.393454] server systemd-resolved[98]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-sshd> server # [423636.393489] server systemd-resolved[98]: 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 # [423636.415506] server systemd-resolved[98]: Using system hostname 'server'. container-test-run-sshd> server # [423636.416910] server systemd[1]: Started Network Name Resolution. container-test-run-sshd> server # [423636.416989] server systemd[1]: Reached target Network. container-test-run-sshd> server # [423636.417054] server systemd[1]: Reached target System Initialization. container-test-run-sshd> server # [423636.417106] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> server # [423636.417142] server systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-sshd> server # [423636.417160] server systemd[1]: Reached target Timer Units. container-test-run-sshd> server # [423636.417277] server systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-sshd> server # [423636.417395] server systemd[1]: Listening on Nix Daemon Socket. container-test-run-sshd> server # [423636.418419] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Export). container-test-run-sshd> server # [423636.419293] server systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). container-test-run-sshd> server # [423636.419744] server systemd[1]: Listening on SSH Socket. container-test-run-sshd> server # [423636.419844] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-sshd> server # [423636.419868] server systemd[1]: Reached target Socket Units. container-test-run-sshd> server # [423636.419912] server systemd[1]: Reached target Basic System. container-test-run-sshd> server # [423636.440407] server systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-sshd> server # [423636.441259] server systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-sshd> server # [423636.441290] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [423636.442798] server systemd[1]: Starting D-Bus System Message Bus... container-test-run-sshd> server # [423636.459415] server systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-sshd> server # [423636.551341] server nsncd[200]: Sep 09 05:07:36.537 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-sshd> server # [423636.551320] server systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-sshd> server # [423636.551383] server systemd[1]: Reached target Host and Network Name Lookups. container-test-run-sshd> server # [423636.551447] server systemd[1]: Reached target User and Group Name Lookups. container-test-run-sshd> server # [423636.592633] server systemd[1]: Starting User Login Management... container-test-run-sshd> client # [423635.748332] client systemd-journald[69]: Journal started container-test-run-sshd> client # [423635.748384] client systemd-journald[69]: Runtime Journal (/run/log/journal/a57f0a15e5064f4fb5b8fc91a9094ce5) is 8M, max 2.5G, 2.4G free. container-test-run-sshd> client # [423635.754978] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-sshd> client # [423635.764771] client systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-sshd> client # [423635.765609] client systemd[1]: Starting Network Name Resolution... container-test-run-sshd> client # [423635.766270] client systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-sshd> client # [423635.775259] client systemd-journald[69]: Time spent on flushing to /var/log/journal/a57f0a15e5064f4fb5b8fc91a9094ce5 is 1.604ms for 6 entries. container-test-run-sshd> client # [423635.775259] client systemd-journald[69]: System Journal (/var/log/journal/a57f0a15e5064f4fb5b8fc91a9094ce5) is 8M, max 4G, 3.9G free. container-test-run-sshd> client # [423635.782172] client systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-sshd> client # [423635.782839] client systemd[1]: Reached target Preparation for Local File Systems. container-test-run-sshd> client # [423635.782972] client systemd[1]: Reached target Local File Systems. container-test-run-sshd> client # [423635.783858] client systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-sshd> client # [423635.783904] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> client # [423635.784739] client systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-sshd> client # [423635.784776] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-sshd> client # [423635.816621] client systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-sshd> client # [423635.818410] client systemd[1]: Starting Create System Files and Directories... container-test-run-sshd> client # [423635.836562] client systemd-tmpfiles[126]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-sshd> client # [423635.836765] client systemd-tmpfiles[126]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-sshd> client # [423635.836904] client systemd-tmpfiles[126]: fchmod() of /var/log/journal/a57f0a15e5064f4fb5b8fc91a9094ce5 failed: Operation not permitted container-test-run-sshd> client # [423635.837118] client systemd-tmpfiles[126]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-sshd> client # [423635.839122] client systemd[1]: Finished Create System Files and Directories. container-test-run-sshd> client # [423635.840432] client systemd[1]: Starting Rebuild Journal Catalog... container-test-run-sshd> client # [423635.841217] client systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-sshd> client # [423635.843108] client systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-sshd> client # [423635.857365] client systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-sshd> client # [423635.864092] client systemd[1]: Finished Rebuild Journal Catalog. container-test-run-sshd> client # [423635.865771] client systemd[1]: Starting Update is Completed... container-test-run-sshd> client # [423635.876303] client systemd[1]: Finished Update is Completed. container-test-run-sshd> client # [423635.912463] client systemd[1]: Finished Firewall. container-test-run-sshd> client # [423635.912643] client systemd[1]: Reached target Preparation for Network. container-test-run-sshd> client # [423635.912897] client systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-sshd> client # [423635.914055] client systemd[1]: Starting Network Management... container-test-run-sshd> client # [423636.346603] client systemd-networkd[183]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-sshd> client # [423636.346695] client systemd-networkd[183]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-sshd> client # [423636.353402] client systemd-networkd[183]: /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 # [423636.353570] client systemd-networkd[183]: /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 # [423636.353719] client systemd-networkd[183]: lo: Link UP container-test-run-sshd> client # [423636.353722] client systemd-networkd[183]: lo: Gained carrier container-test-run-sshd> client # [423636.353890] client systemd-networkd[183]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-sshd> client # [423636.354309] client systemd[1]: Started Network Management. container-test-run-sshd> client # [423636.354380] client systemd-networkd[183]: eth1: Link UP container-test-run-sshd> client # [423636.354691] client systemd-networkd[183]: eth1: Gained carrier container-test-run-sshd> client # [423636.355392] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-sshd> client # [423636.369611] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-sshd> client # [423636.381237] client systemd-resolved[92]: Positive Trust Anchors: container-test-run-sshd> client # [423636.381250] client systemd-resolved[92]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-sshd> client # [423636.381254] client systemd-resolved[92]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-sshd> client # [423636.381289] client systemd-resolved[92]: 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 # [423636.403513] client systemd-resolved[92]: Using system hostname 'client'. container-test-run-sshd> client # [423636.404988] client systemd[1]: Started Network Name Resolution. container-test-run-sshd> client # [423636.405139] client systemd[1]: Reached target Network. container-test-run-sshd> client # [423636.405266] client systemd[1]: Reached target System Initialization. container-test-run-sshd> client # [423636.405357] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-sshd> client # [423636.405416] client systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-sshd> client # [423636.405453] client systemd[1]: Reached target Timer Units. container-test-run-sshd> client # [423636.405678] client systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-sshd> client # [423636.405895] client systemd[1]: Listening on Nix Daemon Socket. container-test-run-sshd> client # [423636.406120] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-sshd> client # [423636.406167] client systemd[1]: Reached target Socket Units. container-test-run-sshd> client # [423636.406244] client systemd[1]: Reached target Basic System. container-test-run-sshd> client # [423636.408031] client systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-sshd> client # [423636.409436] client systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-sshd> client # [423636.411737] client systemd[1]: Starting D-Bus System Message Bus... container-test-run-sshd> client # [423636.457315] client systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-sshd> client # [423636.538358] client nsncd[189]: Sep 09 05:07:36.524 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-sshd> client # [423636.538462] client systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-sshd> client # [423636.538532] client systemd[1]: Reached target Host and Network Name Lookups. container-test-run-sshd> client # [423636.538594] client systemd[1]: Reached target User and Group Name Lookups. container-test-run-sshd> client # [423636.540259] client systemd[1]: Starting User Login Management... container-test-run-sshd> client # [423636.541146] client systemd[1]: Starting Permit User Sessions... container-test-run-sshd> client # [423636.599513] client systemd[1]: Finished Permit User Sessions. container-test-run-sshd> client # [423636.600701] client systemd[1]: Started Console Getty. container-test-run-sshd> client # [423636.600747] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-sshd> client # [423636.600764] client systemd[1]: Reached target Login Prompts. container-test-run-sshd> client # [423636.640672] client dbus-broker-launch[190]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-sshd> client # [423636.641368] client dbus-broker-launch[190]: NSS returned no entry for 'systemd-timesync' container-test-run-sshd> client # [423636.641368] client dbus-broker-launch[190]: Invalid user-name in /nix/store/5xsyadnlhlwnyvziab02f3n7ak7gk87b-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-sshd> client # [423636.641847] client systemd[1]: Started D-Bus System Message Bus. container-test-run-sshd> client # [423636.650236] client dbus-broker-launch[190]: Ready container-test-run-sshd> client # [423636.739255] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-sshd> server # [423636.593576] server systemd[1]: Starting Permit User Sessions... container-test-run-sshd> server # [423636.604195] server systemd[1]: Finished Permit User Sessions. container-test-run-sshd> server # [423636.605740] server systemd[1]: Started Console Getty. container-test-run-sshd> server # [423636.605809] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-sshd> server # [423636.605841] server systemd[1]: Reached target Login Prompts. container-test-run-sshd> server # [423636.615246] server dbus-broker-launch[201]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-sshd> server # [423636.616525] server dbus-broker-launch[201]: NSS returned no entry for 'systemd-timesync' container-test-run-sshd> server # [423636.616567] server dbus-broker-launch[201]: Invalid user-name in /nix/store/khqyrgmh823rqcmbhg0nx2p2clnvzpqz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-sshd> server # [423636.617019] server systemd[1]: Started D-Bus System Message Bus. container-test-run-sshd> server # [423636.624582] server dbus-broker-launch[201]: Ready container-test-run-sshd> server # [423636.738311] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-sshd> client # [423637.032735] client systemd-logind[205]: New seat seat0. container-test-run-sshd> client # [423637.032931] client systemd[1]: Started User Login Management. container-test-run-sshd> client # [423637.034376] client systemd[1]: Starting linger-users.service... container-test-run-sshd> server # [423637.017350] server systemd-logind[216]: New seat seat0. container-test-run-sshd> server # [423637.017964] server systemd[1]: Started User Login Management. container-test-run-sshd> client # [423637.048336] client systemd[1]: linger-users.service: Deactivated successfully. container-test-run-sshd> server # [423637.019854] server systemd[1]: Starting linger-users.service... container-test-run-sshd> client # [423637.048518] client systemd[1]: Finished linger-users.service. container-test-run-sshd> server # [423637.034583] server systemd[1]: linger-users.service: Deactivated successfully. container-test-run-sshd> client # [423637.048908] client systemd[1]: Reached target Multi-User System. container-test-run-sshd> server # [423637.034846] server systemd[1]: Finished linger-users.service. container-test-run-sshd> client # [423637.049062] client systemd[1]: Startup finished in 1.761s. container-test-run-sshd> server # [423637.035760] server systemd[1]: Reached target Multi-User System. container-test-run-sshd> server # [423637.036542] server systemd[1]: Startup finished in 1.732s. 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.65 seconds) 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: (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.13 seconds) container-test-run-sshd> (finished: run the VM test script, in 2.83 seconds) container-test-run-sshd> server # [423637.439551] server systemd[1]: Created slice Slice /system/sshd. container-test-run-sshd> server # [423637.439641] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [423637.440793] server systemd[1]: Started SSH per-connection Daemon (127.0.0.1:40998). container-test-run-sshd> server # [423637.509503] server systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met. container-test-run-sshd> server # [423637.510780] server systemd[1]: Started SSH per-connection Daemon (192.168.1.1:41472). container-test-run-sshd> server # [423637.519695] server sshd-session[231]: Connection closed by 127.0.0.1 port 40998 [preauth] container-test-run-sshd> server # [423637.521113] server systemd[1]: sshd@0-16391-127.0.0.1:22-127.0.0.1:40998.service: Deactivated successfully. container-test-run-sshd> server # [423637.603501] server sshd-session[236]: Accepted publickey for root from 192.168.1.1 port 41472 ssh2: ED25519 SHA256:o/QD6rB73sctZzyYRQeIJAuU+/iqP9mNNwIF4P4uLSc container-test-run-sshd> server # [423637.621054] server sshd-session[243]: Received disconnect from 192.168.1.1 port 41472:11: disconnected by user container-test-run-sshd> server # [423637.621268] server sshd-session[243]: Disconnected from user root 192.168.1.1 port 41472 container-test-run-sshd> server # [423637.622556] server systemd[1]: sshd@1-229380-192.168.1.2:22-192.168.1.1:41472.service: Deactivated successfully. container-test-run-sshd> test script finished in 2.95s 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> Container client terminated by signal KILL. container-test-run-sshd> Container server terminated by signal KILL. container-test-run-sshd> (finished: cleanup, in 0.33 seconds) warning: SQLite database '/nix/var/nix/db/db.sqlite' is busy upload niks3: failed timed out after 3600s