these 53 derivations will be built:
  /nix/store/619yp6azrh2jsi284ihbdn3mabpp439v-unbound.conf.drv
  /nix/store/0vbdzwn3rs56q5kwi8im4cmlhvq9gnxc-X-Restart-Triggers-unbound.drv
  /nix/store/4168d6wlhbcd9bibl435iqxkjxwab4c3-python3.14-nixos-test-lib-1.0.0.drv
  /nix/store/1864a0d08nsln8zr7zllm1qf3zxs54dl-nixos-test-driver-1.1.drv
  /nix/store/cwi31pysnh4rgj05gvn3v6gghvl57xsv-unit-script-unbound-pre-start.drv
  /nix/store/qx55nqib8k90rp8p13zpz8a436wi2ix7-unbound.conf.drv
  /nix/store/zy5qiqr4lvnra8ncrvd8wd1c8qicbwzs-X-Restart-Triggers-unbound.drv
  /nix/store/1hpgjjidjkg0jxnbihna856fbniga6lk-unit-unbound.service.drv
  /nix/store/1nc7w05y5i97fx8w4i0angik30nwrma5-system-path.drv
  /nix/store/79s8z8mdrb7acj9fmgp7dbyn2b35bi7r-dbus-1.drv
  /nix/store/g94fchha9awjbkj526i830yx93pl22zj-X-Restart-Triggers-dbus-broker.drv
  /nix/store/ih0mhhr401s1v3l2pgpkmypa9xxzk7c7-unit-dbus-broker.service.drv
  /nix/store/2va6981bn1bf0krng8bbsrap2vx5ac0p-user-units.drv
  /nix/store/3mxjy1fyyyrz7mrp6x0862716zsbf4ci-string-hosts.drv
  /nix/store/5sjrhrlh6j32xsznmlva3mvma4ya50wq-system-path.drv
  /nix/store/8wih6gk989wpg1qzpfm0xnfk2a5shf3i-users-groups.json.drv
  /nix/store/dpdfmbgf9bw9xm5gnpf879yc9ln1n8k8-etc-systemd-resolved.conf.drv
  /nix/store/n1ljj33v4jrvfk5jfimcym450g8gjsqw-dbus-1.drv
  /nix/store/zli5g31bc2782qsd1gjqal8pmgcj0f89-X-Restart-Triggers-dbus-broker.drv
  /nix/store/50fpwckdhh6xk2cdaax8370r0fxbxhqm-unit-dbus-broker.service.drv
  /nix/store/jasi0vz9nhnwayfmfmz53bmmwrj35mwy-user-units.drv
  /nix/store/vgmmfil8fnyknd6zba99clk4axms5mw6-extra-hosts.drv
  /nix/store/kf2pkp3dkhxg69ghb9hq9r6w0mcf2r8w-hosts.drv
  /nix/store/4q79aqiymilfl8fdh3p4ic3jpa93rwcy-unit-unbound-reload-zones.path.drv
  /nix/store/pqmk4j9492yjn7a4vr47rfwzjsqvr6d9-X-Restart-Triggers-data-mesher.drv
  /nix/store/5m151k4p1q6c7gxz4nwaslq1scs1pg2r-unit-data-mesher.service.drv
  /nix/store/5kf5p07hw9v0zqxxn234yq3367zg24q6-firewall-start.drv
  /nix/store/q9nz22csb5yn22k4275lyrf8i3swdix2-firewall-reload.drv
  /nix/store/gr1hjxy5b94cacq6zbcll53j614bpqq3-unit-firewall.service.drv
  /nix/store/hbk763kmdmmkwx5rriw8ixczmapnksrl-unit-dbus-broker.service.drv
  /nix/store/pp90ghyl3mvndi3n89x8j58k9gp3bvld-unit-unbound.service.drv
  /nix/store/sclsmn7s7a3skplhrvkzvpcjm249p4bw-unit-unbound-reload-zones.service.drv
  /nix/store/jzpbhwygbmlbriq939a6nv6awm395r7k-X-Reload-Triggers-systemd-resolved.drv
  /nix/store/vg90wz5vqq2xacdnpgk8jl7pzhgw0v35-unit-systemd-resolved.service.drv
  /nix/store/n725p984ppsjw2j12lz9gkvzs777sxd9-system-units.drv
  /nix/store/s8bvg5ldg4zfsqh0n4i01kfl90jhc59q-etc.drv
  /nix/store/rh5nnramkcvp31sas3cs4kgvdnbbkjvn-activate.drv
  /nix/store/hlay461kk2p58yy192by5lzw4994q5xy-nixos-system-server-test.drv
  /nix/store/4kqkckpzymb8zfsr64nchm7zxbaa3s60-run-server-nspawn.drv
  /nix/store/4rmvjpjf63p1n1h50blxrx42s6qac2j0-X-Restart-Triggers-data-mesher.drv
  /nix/store/knld3lzqxiygbmh5dpqj76ixljpcy5b7-unit-dbus-broker.service.drv
  /nix/store/qbfgmplvq8g34sl730pry816w6lbs6zx-unit-data-mesher.service.drv
  /nix/store/b8bzxxjhqlsmprsg4kpm3a3x6kqc4jj5-system-units.drv
  /nix/store/7lf8c649rj68c7rl9cd69vkx988hdjlc-string-hosts.drv
  /nix/store/v1xl4xdmkiplz34zx6m8acff3bm17k90-hosts.drv
  /nix/store/jjgar4m89kr4lyyz4d3sf3hk4p33ip3b-etc.drv
  /nix/store/4y5n3chdyncd638lrslrmlwppda58apz-activate.drv
  /nix/store/v9f31kndd5087nnyj4pj6sgy504niiv7-nixos-system-client-test.drv
  /nix/store/5fzn1mic1hnkifpwfi032cabqgmyldn7-run-client-nspawn.drv
  /nix/store/asjp9jcgchla82dhm9pvyf5s45yxmg14-test-script.drv
  /nix/store/dxs33c3pwyhgd5lywkshwvp1knc971dv-driverConfiguration.json.drv
  /nix/store/bglwcdbydy3i6cp7qck3gzcz66z62wm1-nixos-test-driver-dm-dns.drv
  /nix/store/iqgk31limqqpl8nmr1am2chz85b0gzyr-container-test-run-dm-dns.drv
these 11 paths will be fetched (76.6 KiB download, 31.4 MiB unpacked):
  /nix/store/f53knq3ldlxnrcv1lx4j9hbihxvyj7xk-data-mesher-0.1.0
  /nix/store/kdjyrjiill9fr9wb3kgw7y6fsk97zgxd-decrypt-age-secrets
  /nix/store/wxdc6z3bx608whs7f4q6wjdvs6hn9gdn-decrypt-age-secrets
  /nix/store/pwa6ppgl3118wbaqp6ff1r848i2mlljq-dm-send-dns
  /nix/store/7nac2283mfxaggs3w8j8c9w3w24kn1dj-dm.toml
  /nix/store/md5lxp8l019jfifyz32s5jbfmv1a3ilf-dm.toml
  /nix/store/wlh94dc2m9jvdz31p48k4xsg857q1bap-dry-activate
  /nix/store/yg49aakq0a6z4fz00161sz0470q3vkvg-dry-activate
  /nix/store/gxhvjfa1ic9icj0q8v1s4hxlfsc4ijji-unbound-1.26.0-man
  /nix/store/wvksy32i3paxcqrag3bqy5xk96v2km7c-users-groups.json
  /nix/store/nmxvaj40j5a0299y2q7yla66qa4w54lp-vars-check-dm-dns
building '/nix/store/asjp9jcgchla82dhm9pvyf5s45yxmg14-test-script.drv'
building '/nix/store/dpdfmbgf9bw9xm5gnpf879yc9ln1n8k8-etc-systemd-resolved.conf.drv'
building '/nix/store/619yp6azrh2jsi284ihbdn3mabpp439v-unbound.conf.drv'
building '/nix/store/qx55nqib8k90rp8p13zpz8a436wi2ix7-unbound.conf.drv'
building '/nix/store/vgmmfil8fnyknd6zba99clk4axms5mw6-extra-hosts.drv'
building '/nix/store/3mxjy1fyyyrz7mrp6x0862716zsbf4ci-string-hosts.drv'
building '/nix/store/7lf8c649rj68c7rl9cd69vkx988hdjlc-string-hosts.drv'
building '/nix/store/4q79aqiymilfl8fdh3p4ic3jpa93rwcy-unit-unbound-reload-zones.path.drv'
building '/nix/store/sclsmn7s7a3skplhrvkzvpcjm249p4bw-unit-unbound-reload-zones.service.drv'
building '/nix/store/cwi31pysnh4rgj05gvn3v6gghvl57xsv-unit-script-unbound-pre-start.drv'
etc-systemd-resolved.conf> structuredAttrs is enabled
extra-hosts> structuredAttrs is enabled
string-hosts> structuredAttrs is enabled
string-hosts> structuredAttrs is enabled
test-script> structuredAttrs is enabled
unbound.conf> structuredAttrs is enabled
unbound.conf> structuredAttrs is enabled
unit-unbound-reload-zones.path> structuredAttrs is enabled
unit-unbound-reload-zones.service> structuredAttrs is enabled
unit-script-unbound-pre-start> structuredAttrs is enabled
building '/nix/store/jzpbhwygbmlbriq939a6nv6awm395r7k-X-Reload-Triggers-systemd-resolved.drv'
building '/nix/store/0vbdzwn3rs56q5kwi8im4cmlhvq9gnxc-X-Restart-Triggers-unbound.drv'
building '/nix/store/zy5qiqr4lvnra8ncrvd8wd1c8qicbwzs-X-Restart-Triggers-unbound.drv'
building '/nix/store/kf2pkp3dkhxg69ghb9hq9r6w0mcf2r8w-hosts.drv'
building '/nix/store/v1xl4xdmkiplz34zx6m8acff3bm17k90-hosts.drv'
X-Reload-Triggers-systemd-resolved> structuredAttrs is enabled
X-Restart-Triggers-unbound> structuredAttrs is enabled
X-Restart-Triggers-unbound> structuredAttrs is enabled
building '/nix/store/4rmvjpjf63p1n1h50blxrx42s6qac2j0-X-Restart-Triggers-data-mesher.drv'
building '/nix/store/pqmk4j9492yjn7a4vr47rfwzjsqvr6d9-X-Restart-Triggers-data-mesher.drv'
X-Restart-Triggers-data-mesher> structuredAttrs is enabled
X-Restart-Triggers-data-mesher> structuredAttrs is enabled
building '/nix/store/vg90wz5vqq2xacdnpgk8jl7pzhgw0v35-unit-systemd-resolved.service.drv'
building '/nix/store/1hpgjjidjkg0jxnbihna856fbniga6lk-unit-unbound.service.drv'
building '/nix/store/pp90ghyl3mvndi3n89x8j58k9gp3bvld-unit-unbound.service.drv'
unit-systemd-resolved.service> structuredAttrs is enabled
unit-unbound.service> structuredAttrs is enabled
unit-unbound.service> structuredAttrs is enabled
building '/nix/store/1nc7w05y5i97fx8w4i0angik30nwrma5-system-path.drv'
building '/nix/store/5m151k4p1q6c7gxz4nwaslq1scs1pg2r-unit-data-mesher.service.drv'
building '/nix/store/qbfgmplvq8g34sl730pry816w6lbs6zx-unit-data-mesher.service.drv'
system-path> structuredAttrs is enabled
unit-data-mesher.service> structuredAttrs is enabled
unit-data-mesher.service> structuredAttrs is enabled
system-path> created 1734 symlinks in user environment
building '/nix/store/5sjrhrlh6j32xsznmlva3mvma4ya50wq-system-path.drv'
building '/nix/store/79s8z8mdrb7acj9fmgp7dbyn2b35bi7r-dbus-1.drv'
system-path> structuredAttrs is enabled
system-path> created 1735 symlinks in user environment
building '/nix/store/g94fchha9awjbkj526i830yx93pl22zj-X-Restart-Triggers-dbus-broker.drv'
X-Restart-Triggers-dbus-broker> structuredAttrs is enabled
building '/nix/store/ih0mhhr401s1v3l2pgpkmypa9xxzk7c7-unit-dbus-broker.service.drv'
building '/nix/store/knld3lzqxiygbmh5dpqj76ixljpcy5b7-unit-dbus-broker.service.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/n1ljj33v4jrvfk5jfimcym450g8gjsqw-dbus-1.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/2va6981bn1bf0krng8bbsrap2vx5ac0p-user-units.drv'
building '/nix/store/zli5g31bc2782qsd1gjqal8pmgcj0f89-X-Restart-Triggers-dbus-broker.drv'
X-Restart-Triggers-dbus-broker> structuredAttrs is enabled
building '/nix/store/50fpwckdhh6xk2cdaax8370r0fxbxhqm-unit-dbus-broker.service.drv'
building '/nix/store/hbk763kmdmmkwx5rriw8ixczmapnksrl-unit-dbus-broker.service.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/jasi0vz9nhnwayfmfmz53bmmwrj35mwy-user-units.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/b8bzxxjhqlsmprsg4kpm3a3x6kqc4jj5-system-units.drv'
building '/nix/store/n725p984ppsjw2j12lz9gkvzs777sxd9-system-units.drv'
building '/nix/store/jjgar4m89kr4lyyz4d3sf3hk4p33ip3b-etc.drv'
building '/nix/store/s8bvg5ldg4zfsqh0n4i01kfl90jhc59q-etc.drv'
building '/nix/store/4y5n3chdyncd638lrslrmlwppda58apz-activate.drv'
building '/nix/store/rh5nnramkcvp31sas3cs4kgvdnbbkjvn-activate.drv'
activate> structuredAttrs is enabled
building '/nix/store/v9f31kndd5087nnyj4pj6sgy504niiv7-nixos-system-client-test.drv'
activate> structuredAttrs is enabled
building '/nix/store/hlay461kk2p58yy192by5lzw4994q5xy-nixos-system-server-test.drv'
nixos-system-client-test> structuredAttrs is enabled
building '/nix/store/5fzn1mic1hnkifpwfi032cabqgmyldn7-run-client-nspawn.drv'
nixos-system-server-test> structuredAttrs is enabled
building '/nix/store/4kqkckpzymb8zfsr64nchm7zxbaa3s60-run-server-nspawn.drv'
building '/nix/store/dxs33c3pwyhgd5lywkshwvp1knc971dv-driverConfiguration.json.drv'
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/bglwcdbydy3i6cp7qck3gzcz66z62wm1-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/iqgk31limqqpl8nmr1am2chz85b0gzyr-container-test-run-dm-dns.drv' on 'ssh-ng://builder@build-x86-01.clan.lol'
building '/nix/store/iqgk31limqqpl8nmr1am2chz85b0gzyr-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> 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> ░ Spawning container server on /build/vm-state-server.
container-test-run-dm-dns> client # [1201664.334342] client systemd-journald[90]: Journal started
container-test-run-dm-dns> client # [1201664.334388] client systemd-journald[90]: Runtime Journal (/run/log/journal/3f0b009a86594dbc8b54b637eb9917e3) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> client # [1201664.346164] client systemd[1]: Finished Apply Kernel Variables.
container-test-run-dm-dns> client # [1201664.357982] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-dm-dns> client # [1201664.369868] client systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> client # [1201664.370485] client systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> client # [1201664.370975] client systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> client # [1201664.399773] client systemd-journald[90]: Time spent on flushing to /var/log/journal/3f0b009a86594dbc8b54b637eb9917e3 is 1.267ms for 7 entries.
container-test-run-dm-dns> client # [1201664.399773] client systemd-journald[90]: System Journal (/var/log/journal/3f0b009a86594dbc8b54b637eb9917e3) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> client # [1201664.432488] client systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> client # [1201664.433894] client systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> client # [1201664.435355] client systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> client # [1201664.435429] client systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> server # [1201664.326003] server systemd-journald[99]: Journal started
container-test-run-dm-dns> server # [1201664.326053] server systemd-journald[99]: Runtime Journal (/run/log/journal/ec197d99f25b4fdbb8538ff429fbd70f) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> server # [1201664.346183] server systemd[1]: Finished Apply Kernel Variables.
container-test-run-dm-dns> client # [1201664.436090] client systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> server # [1201664.360282] server systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-dm-dns> server # [1201664.395267] server systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> server # [1201664.396009] server systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> client # [1201664.436132] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [1201664.436869] client systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> client # [1201664.437503] client systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> client # [1201664.437526] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> server # [1201664.396609] server systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> client # [1201664.449205] client systemd[1]: Finished Firewall.
container-test-run-dm-dns> server # [1201664.401039] server systemd-journald[99]: Time spent on flushing to /var/log/journal/ec197d99f25b4fdbb8538ff429fbd70f is 1.348ms for 7 entries.
container-test-run-dm-dns> client # [1201664.449476] client systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> server # [1201664.401039] server systemd-journald[99]: System Journal (/var/log/journal/ec197d99f25b4fdbb8538ff429fbd70f) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> client # [1201664.449708] client systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> server # [1201664.432796] server systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> server # [1201664.434912] server systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> client # [1201664.450792] client systemd[1]: Starting Network Management...
container-test-run-dm-dns> server # [1201664.435081] server systemd[1]: Finished Firewall.
container-test-run-dm-dns> client # [1201664.463807] client systemd-tmpfiles[195]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> client # [1201664.463984] client systemd-tmpfiles[195]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [1201664.464248] client systemd-tmpfiles[195]: fchmod() of /var/log/journal/3f0b009a86594dbc8b54b637eb9917e3 failed: Operation not permitted
container-test-run-dm-dns> client # [1201664.464445] client systemd-tmpfiles[195]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [1201664.467935] client systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> client # [1201664.468881] client systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> server # [1201664.436611] server systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> server # [1201664.436669] server systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> server # [1201664.436701] server systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> server # [1201664.437267] server systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> server # [1201664.437412] server systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> client # [1201664.469411] client systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> client # [1201664.477330] client systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> client # [1201664.485789] client systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> client # [1201664.486392] client systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> client # [1201664.492771] client systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> client # [1201664.537097] client systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> server # [1201664.437447] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [1201664.438017] server systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> server # [1201664.438494] server systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> server # [1201664.438514] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> server # [1201664.449224] server systemd[1]: Starting Network Management...
container-test-run-dm-dns> server # [1201664.462346] server systemd-tmpfiles[208]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> server # [1201664.462531] server systemd-tmpfiles[208]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [1201664.462636] server systemd-tmpfiles[208]: fchmod() of /var/log/journal/ec197d99f25b4fdbb8538ff429fbd70f failed: Operation not permitted
container-test-run-dm-dns> server # [1201664.462823] server systemd-tmpfiles[208]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [1201664.465349] server systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> server # [1201664.466210] server systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> server # [1201664.466670] server systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> server # [1201664.476686] server systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> server # [1201664.483891] server systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> server # [1201664.484637] server systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> server # [1201664.493187] server systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> server # [1201664.536177] server systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> server # [1201665.346641] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> server # [1201665.525153] server systemd-networkd[209]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [1201665.525259] server systemd-networkd[209]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [1201665.533541] server systemd-networkd[209]: /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 # [1201665.533720] server systemd-networkd[209]: /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 # [1201665.533838] server systemd-networkd[209]: lo: Link UP
container-test-run-dm-dns> server # [1201665.533844] server systemd-networkd[209]: lo: Gained carrier
container-test-run-dm-dns> server # [1201665.534015] server systemd-networkd[209]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> server # [1201665.534324] server systemd[1]: Started Network Management.
container-test-run-dm-dns> server # [1201665.534372] server systemd-networkd[209]: eth1: Link UP
container-test-run-dm-dns> server # [1201665.534550] server systemd-networkd[209]: eth1: Gained carrier
container-test-run-dm-dns> server # [1201665.535561] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> server # [1201665.575720] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> client # [1201665.357864] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> client # [1201665.547515] client systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> client # [1201665.547596] client systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> client # [1201665.564519] client systemd-networkd[200]: /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 # [1201665.564726] client systemd-networkd[200]: /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 # [1201665.564821] client systemd-networkd[200]: lo: Link UP
container-test-run-dm-dns> client # [1201665.564826] client systemd-networkd[200]: lo: Gained carrier
container-test-run-dm-dns> client # [1201665.564982] client systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> client # [1201665.565282] client systemd[1]: Started Network Management.
container-test-run-dm-dns> client # [1201665.566146] client systemd-networkd[200]: eth1: Link UP
container-test-run-dm-dns> client # [1201665.566281] client systemd-networkd[200]: eth1: Gained carrier
container-test-run-dm-dns> client # [1201665.566396] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> client # [1201665.588285] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> server # [1201666.753120] server systemd-networkd[209]: eth1: Gained IPv6LL
container-test-run-dm-dns> client # [1201666.753086] client systemd-networkd[200]: eth1: Gained IPv6LL
container-test-run-dm-dns> client # [1201667.174906] client systemd-resolved[135]: Positive Trust Anchors:
container-test-run-dm-dns> client # [1201667.174914] client systemd-resolved[135]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> client # [1201667.174917] client systemd-resolved[135]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> client # [1201667.174933] client systemd-resolved[135]: 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 # [1201667.188956] client systemd-resolved[135]: Using system hostname 'client'.
container-test-run-dm-dns> client # [1201667.190373] client systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> client # [1201667.190436] client systemd[1]: Reached target Network.
container-test-run-dm-dns> client # [1201667.190484] client systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> client # [1201667.190545] client systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> client # [1201667.190564] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [1201667.190579] client systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> client # [1201667.190588] client systemd[1]: Reached target Path Units.
container-test-run-dm-dns> client # [1201667.190609] client systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> client # [1201667.190711] client systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> client # [1201667.190783] client systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> client # [1201667.190868] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> client # [1201667.190882] client systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> client # [1201667.190909] client systemd[1]: Reached target Basic System.
container-test-run-dm-dns> client # [1201667.191702] client systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> client # [1201667.192096] client systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> client # [1201667.192558] client systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> client # [1201667.193388] client systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> client # [1201667.227368] client systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> server # [1201667.300376] server systemd-resolved[169]: Positive Trust Anchors:
container-test-run-dm-dns> server # [1201667.300386] server systemd-resolved[169]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> server # [1201667.300390] server systemd-resolved[169]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> server # [1201667.300414] server systemd-resolved[169]: 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 # [1201667.312160] server systemd-resolved[169]: Using system hostname 'server'.
container-test-run-dm-dns> server # [1201667.313200] server systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> server # [1201667.313279] server systemd[1]: Reached target Network.
container-test-run-dm-dns> server # [1201667.313329] server systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> server # [1201667.313396] server systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> server # [1201667.313426] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [1201667.313450] server systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> server # [1201667.313466] server systemd[1]: Reached target Path Units.
container-test-run-dm-dns> server # [1201667.313490] server systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> server # [1201667.313591] server systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> server # [1201667.313669] server systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> server # [1201667.313763] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> server # [1201667.313778] server systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> server # [1201667.313805] server systemd[1]: Reached target Basic System.
container-test-run-dm-dns> server # [1201667.314837] server systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> server # [1201667.315463] server systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> server # [1201667.316062] server systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> server # [1201667.316934] server systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> server # [1201667.345677] server systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> client # [1201667.656575] client nsncd[215]: Sep 18 05:04:42.079 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> client # [1201667.656643] client systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> client # [1201667.656702] client systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> client # [1201667.657407] client systemd[1]: Starting User Login Management...
container-test-run-dm-dns> client # [1201667.657810] client systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> client # [1201667.677928] client systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> client # [1201667.678531] client systemd[1]: Started Console Getty.
container-test-run-dm-dns> client # [1201667.678560] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> client # [1201667.678573] client systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> server # [1201667.782497] server nsncd[224]: Sep 18 05:04:42.205 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> server # [1201667.782654] server systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> server # [1201667.782733] server systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> server # [1201667.783740] server systemd[1]: Starting User Login Management...
container-test-run-dm-dns> server # [1201667.784369] server systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> server # [1201667.809389] server systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> server # [1201667.810063] server systemd[1]: Started Console Getty.
container-test-run-dm-dns> server # [1201667.810086] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> server # [1201667.810098] server systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> client # [1201668.067894] client dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> client # [1201668.068539] client dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> client # [1201668.068539] client dbus-broker-launch[216]: Invalid user-name in /nix/store/7s41q5rx8z79nc79z7z1sy80wihrpl09-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> client # [1201668.068918] client systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> client # [1201668.073769] client dbus-broker-launch[216]: Ready
container-test-run-dm-dns> server # [1201668.107512] server dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> server # [1201668.108113] server dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> server # [1201668.108113] server dbus-broker-launch[225]: Invalid user-name in /nix/store/hwa6i1dv3vhrbmx6ilwhycbz6c5ww9zl-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> server # [1201668.108440] server systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> server # [1201668.112270] server dbus-broker-launch[225]: Ready
container-test-run-dm-dns> client # [1201669.093413] client data-mesher[213]: time=2026-09-18T05:04:43.516Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> client # [1201669.093809] client data-mesher[213]: time=2026-09-18T05:04:43.517Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt: [/dns/client.test/tcp/7946]} {12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> client # [1201669.093835] client data-mesher[213]: time=2026-09-18T05:04:43.517Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> client # [1201669.106105] client data-mesher[213]: time=2026-09-18T05:04:43.529Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> client # [1201669.106193] client data-mesher[213]: time=2026-09-18T05:04:43.529Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> client # [1201669.110332] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="libp2p host created" peer_id=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt 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 # [1201669.110422] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> client # [1201669.110422] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> client # [1201669.110422] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> client # [1201669.110422] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="starting server"
container-test-run-dm-dns> client # [1201669.110507] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> client # [1201669.110540] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> client # [1201669.110574] client data-mesher[213]: time=2026-09-18T05:04:43.533Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> client # [1201669.226649] client data-mesher[213]: time=2026-09-18T05:04:43.649Z level=INFO msg="peer connected" peer_id=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa remote_addr=/ip6/2001:db8:1::2/tcp/7946
container-test-run-dm-dns> server # [1201669.216867] server data-mesher[222]: time=2026-09-18T05:04:43.640Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> server # [1201669.217305] server data-mesher[222]: time=2026-09-18T05:04:43.640Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt: [/dns/client.test/tcp/7946]} {12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> server # [1201669.217348] server data-mesher[222]: time=2026-09-18T05:04:43.640Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> server # [1201669.218935] server data-mesher[222]: time=2026-09-18T05:04:43.642Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> server # [1201669.219023] server data-mesher[222]: time=2026-09-18T05:04:43.642Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> server # [1201669.223330] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="libp2p host created" peer_id=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa 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 # [1201669.223369] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> server # [1201669.223369] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> server # [1201669.223369] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> server # [1201669.223369] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="starting server"
container-test-run-dm-dns> server # [1201669.223473] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> server # [1201669.223535] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> server # [1201669.223594] server data-mesher[222]: time=2026-09-18T05:04:43.646Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> server # [1201669.226416] server data-mesher[222]: time=2026-09-18T05:04:43.649Z level=INFO msg="peer connected" peer_id=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt remote_addr=/ip6/2001:db8:1::1/tcp/7946
container-test-run-dm-dns> client # [1201669.442941] client systemd-logind[233]: New seat seat0.
container-test-run-dm-dns> server # [1201669.571213] server systemd-logind[242]: New seat seat0.
container-test-run-dm-dns> client # [1201669.443104] client systemd[1]: Started User Login Management.
container-test-run-dm-dns> server # [1201669.571415] server systemd[1]: Started User Login Management.
container-test-run-dm-dns> client # [1201669.444077] client systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> server # [1201669.572731] server systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> client # [1201669.468517] client systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> server # [1201669.606130] server systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> client # [1201669.468746] client systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> server # [1201669.606284] server systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> server: still waiting for container 'server' to reach ready state...
container-test-run-dm-dns> client # [1201679.111106] client data-mesher[213]: time=2026-09-18T05:04:53.534Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> client # [1201679.111106] client data-mesher[213]: time=2026-09-18T05:04:53.534Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa timeout=5s
container-test-run-dm-dns> client # [1201679.111594] client data-mesher[213]: time=2026-09-18T05:04:53.534Z level=INFO msg="merging remote state" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> client # [1201679.111594] client data-mesher[213]: time=2026-09-18T05:04:53.534Z level=INFO msg="state exchange complete" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa timeout=5s
container-test-run-dm-dns> client # [1201679.111653] client data-mesher[213]: time=2026-09-18T05:04:53.534Z level=INFO msg="server started"
container-test-run-dm-dns> client # [1201679.111708] client data-mesher[213]: time=2026-09-18T05:04:53.535Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> client # [1201679.111795] client systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> client # [1201679.112711] client systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> client # [1201679.224476] client data-mesher[213]: time=2026-09-18T05:04:53.647Z level=INFO msg="received state sync from peer" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> client # [1201679.224476] client data-mesher[213]: time=2026-09-18T05:04:53.647Z level=INFO msg="merging remote state" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> server # [1201679.111526] server data-mesher[222]: time=2026-09-18T05:04:53.534Z level=INFO msg="received state sync from peer" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201679.111526] server data-mesher[222]: time=2026-09-18T05:04:53.534Z level=INFO msg="merging remote state" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201679.224075] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> server # [1201679.224206] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt timeout=5s
container-test-run-dm-dns> server # [1201679.224559] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=INFO msg="merging remote state" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201679.224559] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=INFO msg="state exchange complete" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt timeout=5s
container-test-run-dm-dns> server # [1201679.224631] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=INFO msg="server started"
container-test-run-dm-dns> server # [1201679.224660] server data-mesher[222]: time=2026-09-18T05:04:53.647Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> server # [1201679.224777] server systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> server # [1201679.225871] server systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> client # [1201681.808525] client unbound-pre-start[263]: Root anchor updated!
container-test-run-dm-dns> client # [1201681.815981] client unbound-pre-start[267]: setup in directory /var/lib/unbound
container-test-run-dm-dns> server # [1201681.950258] server unbound-pre-start[275]: Root anchor updated!
container-test-run-dm-dns> server # [1201681.957729] server unbound-pre-start[279]: setup in directory /var/lib/unbound
container-test-run-dm-dns> server # [1201682.165249] server unbound-pre-start[288]: Certificate request self-signature ok
container-test-run-dm-dns> server # [1201682.165249] server unbound-pre-start[288]: subject=CN=unbound-control
container-test-run-dm-dns> server # [1201682.171014] server unbound-pre-start[279]: removing artifacts
container-test-run-dm-dns> server # [1201682.171926] server unbound-pre-start[279]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> client # [1201682.261374] client unbound-pre-start[276]: Certificate request self-signature ok
container-test-run-dm-dns> client # [1201682.261374] client unbound-pre-start[276]: subject=CN=unbound-control
container-test-run-dm-dns> client # [1201682.267484] client unbound-pre-start[267]: removing artifacts
container-test-run-dm-dns> client # [1201682.268545] client unbound-pre-start[267]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> client # [1201683.406359] client unbound[281]: [281:0] notice: init module 0: validator
container-test-run-dm-dns> client # [1201683.406536] client unbound[281]: [281:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [1201683.410308] client unbound[281]: [281:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> client # [1201683.410426] client systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> client # [1201683.410676] client systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> client # [1201683.410768] client systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> client # [1201683.411530] client systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> client # [1201683.438163] client unbound[281]: [281:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> client # [1201683.438351] client unbound-control[284]: ok
container-test-run-dm-dns> client # [1201683.438398] client unbound[281]: [281: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 # [1201683.438405] client unbound[281]: [281:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> client # [1201683.439365] client systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> client # [1201683.439541] client unbound[281]: [281:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> client # [1201683.439612] client systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> client # [1201683.439789] client systemd[1]: Startup finished in 19.419s.
container-test-run-dm-dns> client # [1201683.440287] client unbound[281]: [281:0] notice: init module 0: validator
container-test-run-dm-dns> client # [1201683.440332] client unbound[281]: [281:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [1201683.442945] client unbound[281]: [281:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server # [1201683.452580] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [1201683.452715] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [1201683.456403] server unbound[293]: [293:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server # [1201683.456485] server systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> server # [1201683.456686] server systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> server # [1201683.456776] server systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> server # [1201683.457634] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> server # [1201683.484628] server unbound[293]: [293:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> server # [1201683.484786] server unbound-control[296]: ok
container-test-run-dm-dns> server # [1201683.484826] 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 # [1201683.484832] 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 # [1201683.485573] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [1201683.485688] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [1201683.485839] server systemd[1]: Startup finished in 19.458s.
container-test-run-dm-dns> server # [1201683.486135] server unbound[293]: [293:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> server # [1201683.486932] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [1201683.486974] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [1201683.490485] server unbound[293]: [293:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server: (finished: waiting for unit unbound.service, in 20.15 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/3cjg26v6b7xnz4xrc8naplmzn6kqbqp2-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/3cjg26v6b7xnz4xrc8naplmzn6kqbqp2-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.02 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/wx1n220i63nlp13ay89xca3zps8qcr6w-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/wx1n220i63nlp13ay89xca3zps8qcr6w-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-dm-dns> server # [1201683.831534] server data-mesher[222]: time=2026-09-18T05:04:58.254Z level=INFO msg=http_request uri=/files/dns/cnames status=204
container-test-run-dm-dns> server # [1201683.831684] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> server # [1201683.858573] server unbound[293]: [293:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> server # [1201683.858668] server unbound-control[312]: ok
container-test-run-dm-dns> server # [1201683.858919] 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 # [1201683.858924] 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 # [1201683.859329] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [1201683.859447] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [1201683.859660] server unbound[293]: [293:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> server # [1201683.860315] server unbound[293]: [293:0] notice: init module 0: validator
container-test-run-dm-dns> server # [1201683.860349] server unbound[293]: [293:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [1201683.862921] server unbound[293]: [293:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> client # [1201684.114084] client data-mesher[213]: time=2026-09-18T05:04:58.537Z level=DEBUG msg="attempting push/pull" peer_count=1
container-test-run-dm-dns> client # [1201684.114472] client data-mesher[213]: time=2026-09-18T05:04:58.537Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa timeout=5s
container-test-run-dm-dns> client # [1201684.114660] client data-mesher[213]: time=2026-09-18T05:04:58.537Z level=INFO msg="merging remote state" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> client # [1201684.114724] client data-mesher[213]: time=2026-09-18T05:04:58.538Z level=DEBUG msg="new file detected" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa name=dns/cnames name=dns/cnames
container-test-run-dm-dns> client # [1201684.114724] client data-mesher[213]: time=2026-09-18T05:04:58.538Z level=INFO msg="state exchange complete" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa timeout=5s
container-test-run-dm-dns> client # [1201684.114724] client data-mesher[213]: time=2026-09-18T05:04:58.538Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-dm-dns> client # [1201684.114781] client data-mesher[213]: time=2026-09-18T05:04:58.538Z level=INFO msg="scheduling file download" name=dns/cnames
container-test-run-dm-dns> client # [1201684.114781] client data-mesher[213]: time=2026-09-18T05:04:58.538Z level=INFO msg="downloading file" name=dns/cnames signed_at="2026-09-18 05:04:58.252 +0000 UTC" signed_by="6ZvaNOCphAV/B66QH82CZIxBG5GoBZ6A/gnNsBS+rXs=" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> client # [1201684.118479] client systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> client # [1201684.119388] client data-mesher[213]: time=2026-09-18T05:04:58.542Z level=INFO msg="download complete" name=dns/cnames signed_at="2026-09-18 05:04:58.252 +0000 UTC" signed_by="6ZvaNOCphAV/B66QH82CZIxBG5GoBZ6A/gnNsBS+rXs=" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa written=true elapsed=4.604412ms
container-test-run-dm-dns> client # [1201684.148164] client unbound[281]: [281:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> client # [1201684.148383] client unbound-control[288]: ok
container-test-run-dm-dns> client # [1201684.148586] client unbound[281]: [281:0] info: server stats for thread 0: 3 queries, 0 answers from cache, 3 recursions, 0 prefetch, 0 rejected by ip ratelimiting
container-test-run-dm-dns> client # [1201684.148592] client unbound[281]: [281:0] info: server stats for thread 0: requestlist max 2 avg 1.33333 exceeded 0 jostled 0
container-test-run-dm-dns> client # [1201684.149281] client systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> client # [1201684.149440] client systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> client # [1201684.150122] client unbound[281]: [281:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> client # [1201684.150756] client unbound[281]: [281:0] notice: init module 0: validator
container-test-run-dm-dns> client # [1201684.150794] client unbound[281]: [281:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [1201684.152733] client unbound[281]: [281:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> client # [1201684.225695] client data-mesher[213]: time=2026-09-18T05:04:58.649Z level=INFO msg="received state sync from peer" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> client # [1201684.225695] client data-mesher[213]: time=2026-09-18T05:04:58.649Z level=INFO msg="merging remote state" peer=12D3KooWHm4j5h7iWHt6sJr9tgKJwPSUTEGZGyMEdnDmtyy4JCWa
container-test-run-dm-dns> server # [1201684.114484] server data-mesher[222]: time=2026-09-18T05:04:58.537Z level=INFO msg="received state sync from peer" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201684.114484] server data-mesher[222]: time=2026-09-18T05:04:58.537Z level=INFO msg="merging remote state" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201684.115071] server data-mesher[222]: time=2026-09-18T05:04:58.538Z level=INFO msg="received file request" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt network="AUn8KJ/TcIX2F2oL9E1EsChI/R30iRJtJGZlhAU0Nng=" name=dns/cnames
container-test-run-dm-dns> server # [1201684.116444] server data-mesher[222]: time=2026-09-18T05:04:58.539Z level=INFO msg="file transfer complete" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt network="AUn8KJ/TcIX2F2oL9E1EsChI/R30iRJtJGZlhAU0Nng=" name=dns/cnames
container-test-run-dm-dns> server # [1201684.225248] server data-mesher[222]: time=2026-09-18T05:04:58.648Z level=DEBUG msg="attempting push/pull" peer_count=1
container-test-run-dm-dns> server # [1201684.225377] server data-mesher[222]: time=2026-09-18T05:04:58.648Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt timeout=5s
container-test-run-dm-dns> server # [1201684.225864] server data-mesher[222]: time=2026-09-18T05:04:58.649Z level=INFO msg="merging remote state" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt
container-test-run-dm-dns> server # [1201684.225911] server data-mesher[222]: time=2026-09-18T05:04:58.649Z level=INFO msg="state exchange complete" peer=12D3KooWPxwAe6wUFxfPKZyKxt8E2L7LDhiGfzt8Eu75Bk9HCNXt timeout=5s
container-test-run-dm-dns> server # [1201684.225911] server data-mesher[222]: time=2026-09-18T05:04:58.649Z level=DEBUG msg="push/pull successful" interval=5s
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.03 seconds)
container-test-run-dm-dns> (finished: run the VM test script, in 21.22 seconds)
container-test-run-dm-dns> test script finished in 22.03s
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.

upload niks3: ok