these 25 derivations will be built:
  /nix/store/r6gkp23rzsz8c2r2r7az10xplbf2r54j-system-path.drv
  /nix/store/zxp3rhj4ils0vm3wbhnicxp2crvs0x34-dbus-1.drv
  /nix/store/d366hvm9qnim2b6izs8d1g6gsgpi2xs6-X-Restart-Triggers-dbus-broker.drv
  /nix/store/kbq8ljjc7snx09kfk965slqlhwdn79gw-unit-dbus-broker.service.drv
  /nix/store/37qfz3z8v653v984zmriivd609hvmzsx-user-units.drv
  /nix/store/l8kri4zqsk42z9h570q4g93x9yk93ia7-unit-dbus-broker.service.drv
  /nix/store/p6j1bjq8zkvpsysy4p68qbi87v8myqqv-system-units.drv
  /nix/store/xgf7pk2hnqiaadaa5ink1wkkwavqd00z-etc.drv
  /nix/store/lh7ilyck1b6plcif5mhk09maxhr900rn-activate.drv
  /nix/store/f3hmflia423681h8hv1mw75zqy8frxb0-nixos-system-server-test.drv
  /nix/store/2jwgw940m03y051drbjnny1hwzrcdxfi-run-server-nspawn.drv
  /nix/store/kgxikg9d0y1ls2nfgj8zc37ky8sjy777-system-path.drv
  /nix/store/krmjrb8s5yallm7yigdzp9pgi6l4q0mc-dbus-1.drv
  /nix/store/50rfqlvw3yvb3nkvcxws80a1szfvfnqz-X-Restart-Triggers-dbus-broker.drv
  /nix/store/cr3j9zkjl2bjm50rw65c68v8igllpmdk-unit-dbus-broker.service.drv
  /nix/store/bc97vmgyazah4ryr5y1bg8iz45k1fnwa-user-units.drv
  /nix/store/bkfmbnl5nda5yfgv2zaadc84pbxm3bgi-unit-dbus-broker.service.drv
  /nix/store/mv2l4q2xa73sjqkslfspvr5if8kvv6k2-system-units.drv
  /nix/store/45i7nwc6lhhjza8ihcdlais9j7k8184m-etc.drv
  /nix/store/x5s27mmg38wqzlgpn4a5mjdsn068gxl3-activate.drv
  /nix/store/c4jwm6ys02ns4g29icm6laf0j14z85gx-nixos-system-client-test.drv
  /nix/store/x2dyc9xxlkdvrcps67dd32xw6x3c2zc7-run-client-nspawn.drv
  /nix/store/7iarix1wwzkd84vvy1q8vwvmahzr4v33-driverConfiguration.json.drv
  /nix/store/y7q9biwv409sff9rl8g8kq4i1aknaz5g-nixos-test-driver-dm-dns.drv
  /nix/store/9xr8kp9wsmplvwb51gq2dyd7maz0591s-container-test-run-dm-dns.drv
this path will be fetched (0.0 KiB download, 98.0 KiB unpacked):
  /nix/store/2219gpwv2z2yzx7a6cigccyzpkdycsx4-unbound-1.26.1-man
warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user
building '/nix/store/r6gkp23rzsz8c2r2r7az10xplbf2r54j-system-path.drv' on nix-store.geninf.io:50051
system-path> gi-build-x86-01: building r6gkp23rzsz8c2r2r7az10xplbf2r54j-system-path.drv
system-path> structuredAttrs is enabled
system-path> created 1733 symlinks in user environment
building '/nix/store/kgxikg9d0y1ls2nfgj8zc37ky8sjy777-system-path.drv' on nix-store.geninf.io:50051
system-path> gi-build-x86-01: building kgxikg9d0y1ls2nfgj8zc37ky8sjy777-system-path.drv
system-path> structuredAttrs is enabled
system-path> created 1732 symlinks in user environment
building '/nix/store/zxp3rhj4ils0vm3wbhnicxp2crvs0x34-dbus-1.drv' on nix-store.geninf.io:50051
dbus-1> gi-build-x86-01: building zxp3rhj4ils0vm3wbhnicxp2crvs0x34-dbus-1.drv
building '/nix/store/krmjrb8s5yallm7yigdzp9pgi6l4q0mc-dbus-1.drv' on nix-store.geninf.io:50051
dbus-1> gi-build-x86-01: building krmjrb8s5yallm7yigdzp9pgi6l4q0mc-dbus-1.drv
building '/nix/store/d366hvm9qnim2b6izs8d1g6gsgpi2xs6-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051
X-Restart-Triggers-dbus-broker> gi-build-x86-01: building d366hvm9qnim2b6izs8d1g6gsgpi2xs6-X-Restart-Triggers-dbus-broker.drv
X-Restart-Triggers-dbus-broker> structuredAttrs is enabled
building '/nix/store/50rfqlvw3yvb3nkvcxws80a1szfvfnqz-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051
X-Restart-Triggers-dbus-broker> gi-build-x86-01: building 50rfqlvw3yvb3nkvcxws80a1szfvfnqz-X-Restart-Triggers-dbus-broker.drv
X-Restart-Triggers-dbus-broker> structuredAttrs is enabled
building '/nix/store/bkfmbnl5nda5yfgv2zaadc84pbxm3bgi-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051
unit-dbus-broker.service> web01: building bkfmbnl5nda5yfgv2zaadc84pbxm3bgi-unit-dbus-broker.service.drv
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/mv2l4q2xa73sjqkslfspvr5if8kvv6k2-system-units.drv' on nix-store.geninf.io:50051
system-units> web01: building mv2l4q2xa73sjqkslfspvr5if8kvv6k2-system-units.drv
building '/nix/store/l8kri4zqsk42z9h570q4g93x9yk93ia7-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051
unit-dbus-broker.service> gi-build-x86-01: building l8kri4zqsk42z9h570q4g93x9yk93ia7-unit-dbus-broker.service.drv
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/cr3j9zkjl2bjm50rw65c68v8igllpmdk-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051
unit-dbus-broker.service> gi-build-x86-01: building cr3j9zkjl2bjm50rw65c68v8igllpmdk-unit-dbus-broker.service.drv
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/bc97vmgyazah4ryr5y1bg8iz45k1fnwa-user-units.drv' on nix-store.geninf.io:50051
user-units> gi-build-x86-01: building bc97vmgyazah4ryr5y1bg8iz45k1fnwa-user-units.drv
building '/nix/store/kbq8ljjc7snx09kfk965slqlhwdn79gw-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051
unit-dbus-broker.service> build-x86-01: building kbq8ljjc7snx09kfk965slqlhwdn79gw-unit-dbus-broker.service.drv
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/p6j1bjq8zkvpsysy4p68qbi87v8myqqv-system-units.drv' on nix-store.geninf.io:50051
system-units> build-x86-01: building p6j1bjq8zkvpsysy4p68qbi87v8myqqv-system-units.drv
building '/nix/store/45i7nwc6lhhjza8ihcdlais9j7k8184m-etc.drv' on nix-store.geninf.io:50051
etc> build-x86-01: building 45i7nwc6lhhjza8ihcdlais9j7k8184m-etc.drv
building '/nix/store/37qfz3z8v653v984zmriivd609hvmzsx-user-units.drv' on nix-store.geninf.io:50051
user-units> gi-build-x86-02: building 37qfz3z8v653v984zmriivd609hvmzsx-user-units.drv
building '/nix/store/x5s27mmg38wqzlgpn4a5mjdsn068gxl3-activate.drv' on nix-store.geninf.io:50051
activate> build-x86-01: building x5s27mmg38wqzlgpn4a5mjdsn068gxl3-activate.drv
activate> structuredAttrs is enabled
building '/nix/store/xgf7pk2hnqiaadaa5ink1wkkwavqd00z-etc.drv' on nix-store.geninf.io:50051
etc> gi-build-x86-02: building xgf7pk2hnqiaadaa5ink1wkkwavqd00z-etc.drv
building '/nix/store/c4jwm6ys02ns4g29icm6laf0j14z85gx-nixos-system-client-test.drv' on nix-store.geninf.io:50051
nixos-system-client-test> build-x86-01: building c4jwm6ys02ns4g29icm6laf0j14z85gx-nixos-system-client-test.drv
nixos-system-client-test> structuredAttrs is enabled
building '/nix/store/lh7ilyck1b6plcif5mhk09maxhr900rn-activate.drv' on nix-store.geninf.io:50051
activate> gi-build-x86-02: building lh7ilyck1b6plcif5mhk09maxhr900rn-activate.drv
activate> structuredAttrs is enabled
building '/nix/store/x2dyc9xxlkdvrcps67dd32xw6x3c2zc7-run-client-nspawn.drv' on nix-store.geninf.io:50051
run-client-nspawn> build-x86-01: building x2dyc9xxlkdvrcps67dd32xw6x3c2zc7-run-client-nspawn.drv
building '/nix/store/f3hmflia423681h8hv1mw75zqy8frxb0-nixos-system-server-test.drv' on nix-store.geninf.io:50051
nixos-system-server-test> gi-build-x86-02: building f3hmflia423681h8hv1mw75zqy8frxb0-nixos-system-server-test.drv
nixos-system-server-test> structuredAttrs is enabled
building '/nix/store/2jwgw940m03y051drbjnny1hwzrcdxfi-run-server-nspawn.drv' on nix-store.geninf.io:50051
run-server-nspawn> gi-build-x86-02: building 2jwgw940m03y051drbjnny1hwzrcdxfi-run-server-nspawn.drv
building '/nix/store/7iarix1wwzkd84vvy1q8vwvmahzr4v33-driverConfiguration.json.drv' on nix-store.geninf.io:50051
driverConfiguration.json> gi-build-x86-02: building 7iarix1wwzkd84vvy1q8vwvmahzr4v33-driverConfiguration.json.drv
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/y7q9biwv409sff9rl8g8kq4i1aknaz5g-nixos-test-driver-dm-dns.drv' on nix-store.geninf.io:50051
nixos-test-driver-dm-dns> gi-build-x86-02: building y7q9biwv409sff9rl8g8kq4i1aknaz5g-nixos-test-driver-dm-dns.drv
nixos-test-driver-dm-dns> Running type check (enable/disable: config.skipTypeCheck)
nixos-test-driver-dm-dns> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck
nixos-test-driver-dm-dns> All checks passed!
nixos-test-driver-dm-dns> Linting test script (enable/disable: config.skipLint)
nixos-test-driver-dm-dns> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint
nixos-test-driver-dm-dns> All checks passed!
building '/nix/store/9xr8kp9wsmplvwb51gq2dyd7maz0591s-container-test-run-dm-dns.drv' on nix-store.geninf.io:50051
container-test-run-dm-dns> build-x86-01: building 9xr8kp9wsmplvwb51gq2dyd7maz0591s-container-test-run-dm-dns.drv
container-test-run-dm-dns> Machine state will be reset. To keep it, pass --keep-machine-state
container-test-run-dm-dns> start all VLans
container-test-run-dm-dns> (finished: start all VLans, in 0.00 seconds)
container-test-run-dm-dns> 
container-test-run-dm-dns> Test will time out and terminate in 3600.0 seconds
container-test-run-dm-dns> run the VM test script
container-test-run-dm-dns> additionally exposed symbols:
container-test-run-dm-dns>     client, server,
container-test-run-dm-dns>     vlan1,
container-test-run-dm-dns>     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-dm-dns> start all VMs
container-test-run-dm-dns> client: systemd-nspawn running (pid 52)
container-test-run-dm-dns> server: systemd-nspawn running (pid 53)
container-test-run-dm-dns> client: Waiting for journal at /build/vm-state-client/var/log/journal...
container-test-run-dm-dns> server: Waiting for journal at /build/vm-state-server/var/log/journal...
container-test-run-dm-dns> (finished: start all VMs, in 0.00 seconds)
container-test-run-dm-dns> server: waiting for unit unbound.service
container-test-run-dm-dns> nixos-nspawn(client): TAP vde-tap1 not found; container will be isolated from VDE
container-test-run-dm-dns> 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-dm-dns> nixos-nspawn(server): TAP vde-tap1 not found; container will be isolated from VDE
container-test-run-dm-dns> 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-dm-dns> 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-dm-dns> ░ Spawning container server on /build/vm-state-server.
container-test-run-dm-dns> 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-dm-dns> ░ Spawning container client on /build/vm-state-client.
container-test-run-dm-dns> client # [2706534.205329] client systemd-journald[90]: Journal started
container-test-run-dm-dns> client # [2706534.205358] client systemd-journald[90]: Runtime Journal (/run/log/journal/24729bec50c8420d9ede726cbb45981a) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> client # [2706534.212745] client systemd[1]: Finished Apply Kernel Variables.
container-test-run-dm-dns> client # [2706534.219098] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-dm-dns> client # [2706534.226471] client systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> client # [2706534.226838] client systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> client # [2706534.227174] client systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> server # [2706534.203538] server systemd-journald[100]: Journal started
container-test-run-dm-dns> client # [2706534.253146] client systemd-journald[90]: Time spent on flushing to /var/log/journal/24729bec50c8420d9ede726cbb45981a is 1.042ms for 7 entries.
container-test-run-dm-dns> server # [2706534.203575] server systemd-journald[100]: Runtime Journal (/run/log/journal/4da64c5582924d0b9a41da8ac4661091) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> client # [2706534.253146] client systemd-journald[90]: System Journal (/var/log/journal/24729bec50c8420d9ede726cbb45981a) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> server # [2706534.213561] server systemd[1]: Finished Apply Kernel Variables.
container-test-run-dm-dns> client # [2706534.262943] client systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> client # [2706534.263152] client systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> server # [2706534.219815] server systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-dm-dns> client # [2706534.263731] client systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> server # [2706534.227024] server systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> client # [2706534.263783] client systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> server # [2706534.227369] server systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> client # [2706534.264195] client systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> server # [2706534.227635] server systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> client # [2706534.264220] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [2706534.251641] server systemd-journald[100]: Time spent on flushing to /var/log/journal/4da64c5582924d0b9a41da8ac4661091 is 1.010ms for 7 entries.
container-test-run-dm-dns> client # [2706534.264566] client systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> server # [2706534.251641] server systemd-journald[100]: System Journal (/var/log/journal/4da64c5582924d0b9a41da8ac4661091) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> client # [2706534.264820] client systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> server # [2706534.262932] server systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> client # [2706534.264834] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> server # [2706534.263136] server systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> client # [2706534.278154] client systemd-tmpfiles[170]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> server # [2706534.263716] server systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> client # [2706534.278297] client systemd-tmpfiles[170]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [2706534.263756] server systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> client # [2706534.278398] client systemd-tmpfiles[170]: fchmod() of /var/log/journal/24729bec50c8420d9ede726cbb45981a failed: Operation not permitted
container-test-run-dm-dns> server # [2706534.264171] server systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> client # [2706534.278544] client systemd-tmpfiles[170]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [2706534.264194] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [2706534.280294] client systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> server # [2706534.264521] server systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> server # [2706534.264831] server systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> client # [2706534.280678] client systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> server # [2706534.264845] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> client # [2706534.280977] client systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> server # [2706534.277050] server systemd-tmpfiles[181]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> client # [2706534.283848] client systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> server # [2706534.277217] server systemd-tmpfiles[181]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [2706534.287407] client systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> server # [2706534.277316] server systemd-tmpfiles[181]: fchmod() of /var/log/journal/4da64c5582924d0b9a41da8ac4661091 failed: Operation not permitted
container-test-run-dm-dns> client # [2706534.292883] client systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> server # [2706534.277463] server systemd-tmpfiles[181]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [2706534.293308] client systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> server # [2706534.278917] server systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> client # [2706534.296748] client systemd[1]: Finished Firewall.
container-test-run-dm-dns> server # [2706534.279515] server systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> client # [2706534.296821] client systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> server # [2706534.279825] server systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> client # [2706534.296983] client systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> server # [2706534.283611] server systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> client # [2706534.297534] client systemd[1]: Starting Network Management...
container-test-run-dm-dns> server # [2706534.287174] server systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> client # [2706534.298416] client systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> server # [2706534.292803] server systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> server # [2706534.293263] server systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> server # [2706534.294317] server systemd[1]: Finished Firewall.
container-test-run-dm-dns> server # [2706534.294458] server systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> server # [2706534.294578] server systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> server # [2706534.295017] server systemd[1]: Starting Network Management...
container-test-run-dm-dns> server # [2706534.299389] server systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> server # [2706534.725330] server systemd-networkd[217]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [2706534.725397] server systemd-networkd[217]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [2706534.732440] server systemd-networkd[217]: /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-dm-dns> server # [2706534.732584] server systemd-networkd[217]: /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-dm-dns> server # [2706534.732653] server systemd-networkd[217]: lo: Link UP
container-test-run-dm-dns> server # [2706534.732656] server systemd-networkd[217]: lo: Gained carrier
container-test-run-dm-dns> server # [2706534.732793] server systemd-networkd[217]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> server # [2706534.733043] server systemd[1]: Started Network Management.
container-test-run-dm-dns> server # [2706534.733054] server systemd-networkd[217]: eth1: Link UP
container-test-run-dm-dns> server # [2706534.733186] server systemd-networkd[217]: eth1: Gained carrier
container-test-run-dm-dns> server # [2706534.733582] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> server # [2706534.764132] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> client # [2706534.726332] client systemd-networkd[207]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> client # [2706534.726399] client systemd-networkd[207]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> client # [2706534.733317] client systemd-networkd[207]: /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-dm-dns> client # [2706534.733455] client systemd-networkd[207]: /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-dm-dns> client # [2706534.733513] client systemd-networkd[207]: lo: Link UP
container-test-run-dm-dns> client # [2706534.733517] client systemd-networkd[207]: lo: Gained carrier
container-test-run-dm-dns> client # [2706534.733624] client systemd-networkd[207]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> client # [2706534.733860] client systemd[1]: Started Network Management.
container-test-run-dm-dns> client # [2706534.733860] client systemd-networkd[207]: eth1: Link UP
container-test-run-dm-dns> client # [2706534.733972] client systemd-networkd[207]: eth1: Gained carrier
container-test-run-dm-dns> client # [2706534.734363] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> client # [2706534.764128] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> client # [2706535.069960] client systemd-resolved[127]: Positive Trust Anchors:
container-test-run-dm-dns> client # [2706535.069967] client systemd-resolved[127]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> client # [2706535.069971] client systemd-resolved[127]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> client # [2706535.069986] client systemd-resolved[127]: 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-dm-dns> client # [2706535.080209] client systemd-resolved[127]: Using system hostname 'client'.
container-test-run-dm-dns> client # [2706535.081422] client systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> client # [2706535.081475] client systemd[1]: Reached target Network.
container-test-run-dm-dns> client # [2706535.081510] client systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> client # [2706535.081560] client systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> client # [2706535.081577] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [2706535.081592] client systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> client # [2706535.081602] client systemd[1]: Reached target Path Units.
container-test-run-dm-dns> client # [2706535.081619] client systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> client # [2706535.081703] client systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> client # [2706535.081782] client systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> client # [2706535.081852] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> client # [2706535.081875] client systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> client # [2706535.081895] client systemd[1]: Reached target Basic System.
container-test-run-dm-dns> client # [2706535.082603] client systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> client # [2706535.082935] client systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> client # [2706535.083308] client systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> client # [2706535.083876] client systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> client # [2706535.113694] client systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> client # [2706535.202184] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> client # [2706535.213377] client nsncd[215]: Oct 05 15:05:49.636 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> client # [2706535.213403] client systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> client # [2706535.213434] client systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> client # [2706535.213975] client systemd[1]: Starting User Login Management...
container-test-run-dm-dns> client # [2706535.214278] client systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> client # [2706535.235793] client systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> client # [2706535.236311] client systemd[1]: Started Console Getty.
container-test-run-dm-dns> client # [2706535.236329] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> client # [2706535.236339] client systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> client # [2706535.330953] client dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> client # [2706535.331392] client dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> client # [2706535.331392] client dbus-broker-launch[216]: Invalid user-name in /nix/store/xx3r7nrzg7pagf9bjhhrknlxrm8mpy60-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> server # [2706535.072908] server systemd-resolved[139]: Positive Trust Anchors:
container-test-run-dm-dns> server # [2706535.072919] server systemd-resolved[139]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> server # [2706535.072922] server systemd-resolved[139]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> server # [2706535.072938] server systemd-resolved[139]: 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-dm-dns> server # [2706535.084044] server systemd-resolved[139]: Using system hostname 'server'.
container-test-run-dm-dns> server # [2706535.084957] server systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> server # [2706535.085019] server systemd[1]: Reached target Network.
container-test-run-dm-dns> server # [2706535.085058] server systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> server # [2706535.085110] server systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> server # [2706535.085134] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [2706535.085151] server systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> server # [2706535.085161] server systemd[1]: Reached target Path Units.
container-test-run-dm-dns> server # [2706535.085182] server systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> server # [2706535.085260] server systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> server # [2706535.085328] server systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> server # [2706535.085398] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> server # [2706535.085407] server systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> server # [2706535.085427] server systemd[1]: Reached target Basic System.
container-test-run-dm-dns> server # [2706535.105200] server systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> server # [2706535.105699] server systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> server # [2706535.106125] server systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> server # [2706535.106682] server systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> server # [2706535.115552] server systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> server # [2706535.200694] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> server # [2706535.213735] server nsncd[225]: Oct 05 15:05:49.637 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> server # [2706535.213757] server systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> server # [2706535.213792] server systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> server # [2706535.214352] server systemd[1]: Starting User Login Management...
container-test-run-dm-dns> server # [2706535.214640] server systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> server # [2706535.235808] server systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> server # [2706535.236313] server systemd[1]: Started Console Getty.
container-test-run-dm-dns> server # [2706535.236331] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> server # [2706535.236340] server systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> server # [2706535.331264] server dbus-broker-launch[226]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> server # [2706535.331672] server dbus-broker-launch[226]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> server # [2706535.331672] server dbus-broker-launch[226]: Invalid user-name in /nix/store/qd8x0nrrb1vph7am4x2imww384fbpk83-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> client # [2706535.331661] client systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> client # [2706535.334903] client dbus-broker-launch[216]: Ready
container-test-run-dm-dns> server # [2706535.332039] server systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> server # [2706535.335480] server dbus-broker-launch[226]: Ready
container-test-run-dm-dns> server # [2706535.629380] server data-mesher[223]: time=2026-10-05T15:05:50.052Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> server # [2706535.629651] server data-mesher[223]: time=2026-10-05T15:05:50.052Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR: [/dns/client.test/tcp/7946]} {12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT
container-test-run-dm-dns> server # [2706535.629668] server data-mesher[223]: time=2026-10-05T15:05:50.052Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> server # [2706535.630896] server data-mesher[223]: time=2026-10-05T15:05:50.054Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> server # [2706535.630974] server data-mesher[223]: time=2026-10-05T15:05:50.054Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> server # [2706535.632703] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="libp2p host created" peer_id=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.2/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::2/tcp/7946]"
container-test-run-dm-dns> server # [2706535.632733] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> server # [2706535.632733] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> server # [2706535.632733] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> server # [2706535.632733] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="starting server"
container-test-run-dm-dns> server # [2706535.632814] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> server # [2706535.632831] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> server # [2706535.632831] server data-mesher[223]: time=2026-10-05T15:05:50.056Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> server # [2706535.635123] server data-mesher[223]: time=2026-10-05T15:05:50.058Z level=INFO msg="peer connected" peer_id=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-dm-dns> server # [2706535.662490] server data-mesher[223]: time=2026-10-05T15:05:50.085Z level=INFO msg="peer connected" peer_id=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR remote_addr=/ip4/192.168.1.1/tcp/45442
container-test-run-dm-dns> server # [2706535.768644] server systemd-logind[243]: New seat seat0.
container-test-run-dm-dns> server # [2706535.768762] server systemd[1]: Started User Login Management.
container-test-run-dm-dns> server # [2706535.769572] server systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> server # [2706535.795940] server systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> server # [2706535.795993] server systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> client # [2706535.625337] client data-mesher[213]: time=2026-10-05T15:05:50.048Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> client # [2706535.625677] client data-mesher[213]: time=2026-10-05T15:05:50.048Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR: [/dns/client.test/tcp/7946]} {12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR
container-test-run-dm-dns> client # [2706535.625677] client data-mesher[213]: time=2026-10-05T15:05:50.048Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> client # [2706535.627844] client data-mesher[213]: time=2026-10-05T15:05:50.051Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> client # [2706535.627908] client data-mesher[213]: time=2026-10-05T15:05:50.051Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> client # [2706535.631012] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="libp2p host created" peer_id=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.1/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::1/tcp/7946]"
container-test-run-dm-dns> client # [2706535.631043] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> client # [2706535.631043] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> client # [2706535.631043] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> client # [2706535.631043] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="starting server"
container-test-run-dm-dns> client # [2706535.631133] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> client # [2706535.631169] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> client # [2706535.631186] client data-mesher[213]: time=2026-10-05T15:05:50.054Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> client # [2706535.635336] client data-mesher[213]: time=2026-10-05T15:05:50.058Z level=INFO msg="peer connected" peer_id=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-dm-dns> client # [2706535.662301] client data-mesher[213]: time=2026-10-05T15:05:50.085Z level=INFO msg="peer connected" peer_id=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-dm-dns> client # [2706535.768938] client systemd-logind[233]: New seat seat0.
container-test-run-dm-dns> client # [2706535.769037] client systemd[1]: Started User Login Management.
container-test-run-dm-dns> client # [2706535.769754] client systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> client # [2706535.795514] client systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> client # [2706535.795607] client systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> server # [2706536.129071] server systemd-networkd[217]: eth1: Gained IPv6LL
container-test-run-dm-dns> client # [2706536.384112] client systemd-networkd[207]: eth1: Gained IPv6LL
container-test-run-dm-dns> server: still waiting for container 'server' to reach ready state...
container-test-run-dm-dns> server # [2706545.632464] server data-mesher[223]: time=2026-10-05T15:06:00.055Z level=INFO msg="received state sync from peer" peer=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR
container-test-run-dm-dns> server # [2706545.632464] server data-mesher[223]: time=2026-10-05T15:06:00.055Z level=INFO msg="merging remote state" peer=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR
container-test-run-dm-dns> server # [2706545.633759] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> server # [2706545.633759] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR timeout=5s
container-test-run-dm-dns> server # [2706545.634032] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=INFO msg="merging remote state" peer=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR
container-test-run-dm-dns> server # [2706545.634032] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=INFO msg="state exchange complete" peer=12D3KooWHZkEHN3w11MRbGDsb1gbEKcW65M5e74fQa3Z9SMoeBuR timeout=5s
container-test-run-dm-dns> server # [2706545.634082] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=INFO msg="server started"
container-test-run-dm-dns> server # [2706545.634112] server data-mesher[223]: time=2026-10-05T15:06:00.057Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> server # [2706545.634157] server systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> server # [2706545.634898] server systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> client # [2706545.632096] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> client # [2706545.632484] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT timeout=5s
container-test-run-dm-dns> client # [2706545.632536] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=INFO msg="merging remote state" peer=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT
container-test-run-dm-dns> client # [2706545.632536] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=INFO msg="state exchange complete" peer=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT timeout=5s
container-test-run-dm-dns> client # [2706545.632571] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=INFO msg="server started"
container-test-run-dm-dns> client # [2706545.632640] client data-mesher[213]: time=2026-10-05T15:06:00.055Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> client # [2706545.632702] client systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> client # [2706545.633578] client systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> client # [2706545.633985] client data-mesher[213]: time=2026-10-05T15:06:00.057Z level=INFO msg="received state sync from peer" peer=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT
container-test-run-dm-dns> client # [2706545.633985] client data-mesher[213]: time=2026-10-05T15:06:00.057Z level=INFO msg="merging remote state" peer=12D3KooWAowQLrcj6qP1hcaxg4qaeqw2kzHh45nA5xGajhFQD6HT
container-test-run-dm-dns> server # [2706546.243475] server unbound-pre-start[275]: Root anchor updated!
container-test-run-dm-dns> server # [2706546.249976] server unbound-pre-start[279]: setup in directory /var/lib/unbound
container-test-run-dm-dns> client # [2706546.243689] client unbound-pre-start[264]: Root anchor updated!
container-test-run-dm-dns> client # [2706546.250185] client unbound-pre-start[268]: setup in directory /var/lib/unbound
container-test-run-dm-dns> client # [2706546.453262] client unbound-pre-start[277]: Certificate request self-signature ok
container-test-run-dm-dns> client # [2706546.453262] client unbound-pre-start[277]: subject=CN=unbound-control
container-test-run-dm-dns> client # [2706546.459054] client unbound-pre-start[268]: removing artifacts
container-test-run-dm-dns> client # [2706546.459956] client unbound-pre-start[268]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> server # [2706546.505578] server unbound-pre-start[288]: Certificate request self-signature ok
container-test-run-dm-dns> server # [2706546.505578] server unbound-pre-start[288]: subject=CN=unbound-control
container-test-run-dm-dns> server # [2706546.509959] server unbound-pre-start[279]: removing artifacts
container-test-run-dm-dns> server # [2706546.510827] server unbound-pre-start[279]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> server: (finished: waiting for unit unbound.service, in 13.64 seconds)
container-test-run-dm-dns> client: waiting for unit unbound.service
container-test-run-dm-dns> client: (finished: waiting for unit unbound.service, in 0.01 seconds)
container-test-run-dm-dns> server: waiting for unit data-mesher.service
container-test-run-dm-dns> server: (finished: waiting for unit data-mesher.service, in 0.01 seconds)
container-test-run-dm-dns> server: waiting for success: dig +short @127.0.0.1 -p 5353 server.test A | grep 10.0.0.1
container-test-run-dm-dns> server: (finished: waiting for success: dig +short @127.0.0.1 -p 5353 server.test A | grep 10.0.0.1, in 0.01 seconds)
container-test-run-dm-dns> server: must succeed: data-mesher file update --network-id /nix/store/ya74963lp9691nsd7vhnfhhmxkn174np-shared-data-mesher-network_network.pub /nix/store/4g9kvmaqs34gisvxgf61p42p665lx8dx-shared-dm-dns_zone.conf --url http://localhost:7331 --key /run/secrets/shared/dm-dns-signing-key/signing.key --name dns/cnames
container-test-run-dm-dns> server: (finished: must succeed: data-mesher file update --network-id /nix/store/ya74963lp9691nsd7vhnfhhmxkn174np-shared-data-mesher-network_network.pub /nix/store/4g9kvmaqs34gisvxgf61p42p665lx8dx-shared-dm-dns_zone.conf --url http://localhost:7331 --key /run/secrets/shared/dm-dns-signing-key/signing.key --name dns/cnames, in 0.01 seconds)
container-test-run-dm-dns> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.
container-test-run-dm-dns>     File "/nix/store/2dz8bfsj1j9rgxlyrgm856siav96qnip-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-dm-dns> server: waiting for success: dig +short @127.0.0.1 -p 5353 myapp.test CNAME | grep server.test
container-test-run-dm-dns> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.
container-test-run-dm-dns>     File "/nix/store/2dz8bfsj1j9rgxlyrgm856siav96qnip-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-dm-dns> server # [2706547.119283] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [2706547.119401] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [2706547.122504] server unbound[293]: [293:0] info: start of service (unbound 1.26.1).
container-test-run-dm-dns> server # [2706547.122571] server systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> server # [2706547.122760] server systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> server # [2706547.122864] server systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> server # [2706547.123478] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> server # [2706547.142864] server unbound[293]: [293:0] info: service stopped (unbound 1.26.1).
container-test-run-dm-dns> server # [2706547.142973] server unbound-control[296]: ok
container-test-run-dm-dns> server # [2706547.143144] server unbound[293]: [293:0] info: server stats for thread 0: 1 queries, 0 answers from cache, 1 recursions, 0 prefetch, 0 rejected by ip ratelimiting
container-test-run-dm-dns> server # [2706547.143147] server unbound[293]: [293:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> server # [2706547.143270] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [2706547.143354] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [2706547.143456] server systemd[1]: Startup finished in 13.178s.
container-test-run-dm-dns> server # [2706547.143766] server unbound[293]: [293:0] notice: Restart of unbound 1.26.1.
container-test-run-dm-dns> server # [2706547.144266] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [2706547.144312] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [2706547.146411] server unbound[293]: [293:0] info: start of service (unbound 1.26.1).
container-test-run-dm-dns> server # [2706547.365123] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> server # [2706547.365458] server data-mesher[223]: time=2026-10-05T15:06:01.788Z level=INFO msg=http_request uri=/files/dns/cnames status=204
container-test-run-dm-dns> client # [2706547.081256] client unbound[282]: [282:0] notice: init module 0: validator
container-test-run-dm-dns> client # [2706547.081378] client unbound[282]: [282:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [2706547.084566] client unbound[282]: [282:0] info: start of service (unbound 1.26.1).
container-test-run-dm-dns> client # [2706547.084630] client systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> client # [2706547.084801] client systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> client # [2706547.084875] client systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> client # [2706547.085552] client systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> client # [2706547.111480] client unbound[282]: [282:0] info: service stopped (unbound 1.26.1).
container-test-run-dm-dns> client # [2706547.111606] client unbound-control[285]: ok
container-test-run-dm-dns> client # [2706547.111759] client unbound[282]: [282:0] info: server stats for thread 0: 1 queries, 0 answers from cache, 1 recursions, 0 prefetch, 0 rejected by ip ratelimiting
container-test-run-dm-dns> client # [2706547.111763] client unbound[282]: [282:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> client # [2706547.112285] client systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> client # [2706547.112430] client systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> client # [2706547.112505] client unbound[282]: [282:0] notice: Restart of unbound 1.26.1.
container-test-run-dm-dns> client # [2706547.112560] client systemd[1]: Startup finished in 13.152s.
container-test-run-dm-dns> client # [2706547.112961] client unbound[282]: [282:0] notice: init module 0: validator
container-test-run-dm-dns> client # [2706547.113015] client unbound[282]: [282:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [2706547.115371] client unbound[282]: [282:0] info: start of service (unbound 1.26.1).
container-test-run-dm-dns> server # [2706547.390970] server unbound[293]: [293:0] info: service stopped (unbound 1.26.1).
container-test-run-dm-dns> server # [2706547.391077] server unbound-control[320]: ok
container-test-run-dm-dns> server # [2706547.391275] server unbound[293]: [293:0] info: server stats for thread 0: 3 queries, 2 answers from cache, 1 recursions, 0 prefetch, 0 rejected by ip ratelimiting
container-test-run-dm-dns> server # [2706547.391279] server unbound[293]: [293:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> server # [2706547.391807] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [2706547.391918] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [2706547.392042] server unbound[293]: [293:0] notice: Restart of unbound 1.26.1.
container-test-run-dm-dns> server # [2706547.392505] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [2706547.392537] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [2706547.394814] server unbound[293]: [293:0] info: start of service (unbound 1.26.1).
container-test-run-dm-dns> server: (finished: waiting for success: dig +short @127.0.0.1 -p 5353 myapp.test CNAME | grep server.test, in 1.02 seconds)
container-test-run-dm-dns> (finished: run the VM test script, in 14.71 seconds)
container-test-run-dm-dns> test script finished in 14.74s
container-test-run-dm-dns> cleanup
container-test-run-dm-dns> kill NspawnMachine (pid 52)
container-test-run-dm-dns> kill NspawnMachine (pid 53)
container-test-run-dm-dns> Container client terminated by signal KILL.
container-test-run-dm-dns> (finished: cleanup, in 0.18 seconds)
container-test-run-dm-dns> Container server terminated by signal KILL.