these 60 derivations will be built:
  /nix/store/0kl5zjklw4qc2nrj99dy8j773zmfprvc-unbound.conf.drv
  /nix/store/0vmzdbjs7dln9vv003cr49r2fhb6wbp8-dm.toml.drv
  /nix/store/pqiqrs7jd5sxg7qbg060bwazmy9cnrg9-unbound.conf.drv
  /nix/store/19hg0fppc085hf7iq90f34didimbzjla-X-Restart-Triggers-unbound.drv
  /nix/store/2wnj6ksszsvqlhr8s8qj8wlwkb4n6kxy-users-groups.json.drv
  /nix/store/6y3r1scm1bw4f661g6gyr5gs9kahsxcp-dm-send-dns.drv
  /nix/store/pc7w56kfm4930hpg4z7zqsw50vcicwls-system-path.drv
  /nix/store/rklghdsnkv2xvn92ykgflivqwqs1lb9h-dbus-1.drv
  /nix/store/9mbxqvihfhd285z7ps1abn288d2walad-X-Restart-Triggers-dbus-broker.drv
  /nix/store/dssfbqabaxlm47g7p8ggvia3wsc6v8zb-unit-dbus-broker.service.drv
  /nix/store/2jr4qhaprxvp9b74bxaxirw1h8x60nwb-user-units.drv
  /nix/store/6k3k79dnc2ixfsq68p6jk75ynrb2yrvl-dm.toml.drv
  /nix/store/km401bazx63jhyi27miraryva4cd23bb-string-hosts.drv
  /nix/store/zwfgsanxzk4zcmshsr0fm1r2nwh1ks4q-extra-hosts.drv
  /nix/store/albxgsjy52ycykwnhcynsmkkpbqagx7s-hosts.drv
  /nix/store/khv1ii4sxd8pcbqdb0s49kl0wb020yjw-etc-systemd-resolved.conf.drv
  /nix/store/wd1n19idiilglr8j803pbv3r5k9iqvbq-vars-check-dm-dns.drv
  /nix/store/51ws0sjyngq44nvh82lqgrpy9i1hljx9-unit-unbound-reload-zones.service.drv
  /nix/store/75qka3bga0dl936g8c9lm4mhmk827jbc-unit-unbound-reload-zones.path.drv
  /nix/store/fmxwyz4llm0px77saczf7dxb6ncjaygh-X-Reload-Triggers-systemd-resolved.drv
  /nix/store/7v207imi630ddc32q7kzm32avqcyhcg7-unit-systemd-resolved.service.drv
  /nix/store/h1x6k1j420yp5fkr53ymqcr1s78vbdd0-unit-script-unbound-pre-start.drv
  /nix/store/9r5ns9kcagnrc32bzy56rz0yychicwsp-unit-unbound.service.drv
  /nix/store/d5riqr1psrdjjh9is0zgk5m1n4nvs0wz-firewall-start.drv
  /nix/store/mfl304f2pxh5y9kv0by9v81q6p554871-firewall-reload.drv
  /nix/store/sm5hm41x31p3m9y15g3lahd4zpmkbxvk-unit-firewall.service.drv
  /nix/store/6hfidg6cvmdmic08cpwnqq4fdpg9d6fi-X-Restart-Triggers-data-mesher.drv
  /nix/store/yh2bc6x986hwd996fic0zrc1gl05nhax-unit-data-mesher.service.drv
  /nix/store/zkfhkar8wpi47306ff3d913c7n9flj5r-unit-dbus-broker.service.drv
  /nix/store/zh9z6wv850rvnf6wpfdblbqhss1hb3qk-system-units.drv
  /nix/store/3n34h4534qmair6srz4czqxp845rr9dx-etc.drv
  /nix/store/bvr8amqmwy350rkdmxn3fd0q94s2v0cs-decrypt-age-secrets.drv
  /nix/store/1j66ddcr6rdaqs82401l9i1yvds86kyr-activate.drv
  /nix/store/6fqxjdrd067g2lfb83zijbym88b70acy-test-script.drv
  /nix/store/hjkngspdgyfaf4s851hg3ys5wlkyq9qg-nixos-test-driver-1.1.drv
  /nix/store/xciwjp8rhyqfkvx6ngidypgghs283ndw-system-path.drv
  /nix/store/96r9vvffa7z9jqihl9f0brcf4n8wy2bi-dbus-1.drv
  /nix/store/6zvk8rzcz0fwbmxr51rd47nyibfwpcs7-X-Restart-Triggers-dbus-broker.drv
  /nix/store/hi057f63zvz15xfyqd6cffkhjv0myr5d-unit-dbus-broker.service.drv
  /nix/store/ac0gp8ra1zlj4f3rc73rr67py7vv11j7-user-units.drv
  /nix/store/5zli8fn1drvn3kbabzxwdjkbjz3pg1aw-unit-dbus-broker.service.drv
  /nix/store/9r2nc09byvf0f5j71xga2cahsfdb5l12-X-Restart-Triggers-data-mesher.drv
  /nix/store/ad6airxm3r48vzsq75a4qp7hv1xb7wpk-unit-data-mesher.service.drv
  /nix/store/9vmqwcj9zbpcp5n90njn14ljhnjgs15q-X-Restart-Triggers-unbound.drv
  /nix/store/d0r78mv551vk7vyc6w02dz6cmiw5a5yq-unit-unbound.service.drv
  /nix/store/gnq0c4gs9822cpyzsia10z5vl0qwvh7l-system-units.drv
  /nix/store/lr92alggvydngj8np4ixlrz1rypi68yj-string-hosts.drv
  /nix/store/r579j5ndqk7dljywsh8yrmrzyy3zpfsa-hosts.drv
  /nix/store/hm6zsl6gx95z4x1b5azcwcij185x9kwi-etc.drv
  /nix/store/j8nxz2cmgir79xs7cqb0jr87aba34cf8-decrypt-age-secrets.drv
  /nix/store/jwfxnjfjqnj8q1k0f8fdkwv9vigqqk8x-dry-activate.drv
  /nix/store/yd54386rn153q8iirs7yiz8lrv2615n6-activate.drv
  /nix/store/giv2amg80g02hgpx92g55cy4bclsnw25-nixos-system-client-test.drv
  /nix/store/7ni49pxh7jmbzy3719i3r97qjn38g4n8-run-client-nspawn.drv
  /nix/store/bp637mmra1sdfhpi3my0b5yxr7biqknc-dry-activate.drv
  /nix/store/49r3y9ciklhj49p7id575mkr937k6lbl-nixos-system-server-test.drv
  /nix/store/dhmrf2knwchgs46ij4zd5dccfw4rni25-run-server-nspawn.drv
  /nix/store/w7pyg1skn9qc02r757qdyqvq68v93544-driverConfiguration.json.drv
  /nix/store/x5lhgmx28manzz5dzinwc230z2ds3rmw-nixos-test-driver-dm-dns.drv
  /nix/store/2k506in99iany1cyihy0nvjng4r8xfkj-container-test-run-dm-dns.drv
these 3 paths will be fetched (1.7 MiB download, 4.2 MiB unpacked):
  /nix/store/6396ha36mxdl1kilz9539ll06ighaqmd-unbound-1.26.0
  /nix/store/mlrhm3yc41q0bflda9vz6hcz27s3lrgz-unbound-1.26.0-lib
  /nix/store/vacpsgmhg92n23cml823b0ya146mcjgz-unbound-1.26.0-man
building '/nix/store/6fqxjdrd067g2lfb83zijbym88b70acy-test-script.drv'
building '/nix/store/khv1ii4sxd8pcbqdb0s49kl0wb020yjw-etc-systemd-resolved.conf.drv'
building '/nix/store/0kl5zjklw4qc2nrj99dy8j773zmfprvc-unbound.conf.drv'
building '/nix/store/pqiqrs7jd5sxg7qbg060bwazmy9cnrg9-unbound.conf.drv'
building '/nix/store/zwfgsanxzk4zcmshsr0fm1r2nwh1ks4q-extra-hosts.drv'
building '/nix/store/km401bazx63jhyi27miraryva4cd23bb-string-hosts.drv'
building '/nix/store/lr92alggvydngj8np4ixlrz1rypi68yj-string-hosts.drv'
building '/nix/store/75qka3bga0dl936g8c9lm4mhmk827jbc-unit-unbound-reload-zones.path.drv'
building '/nix/store/d5riqr1psrdjjh9is0zgk5m1n4nvs0wz-firewall-start.drv'
unit-unbound-reload-zones.path> structuredAttrs is enabled
building '/nix/store/fmxwyz4llm0px77saczf7dxb6ncjaygh-X-Reload-Triggers-systemd-resolved.drv'
building '/nix/store/19hg0fppc085hf7iq90f34didimbzjla-X-Restart-Triggers-unbound.drv'
building '/nix/store/9vmqwcj9zbpcp5n90njn14ljhnjgs15q-X-Restart-Triggers-unbound.drv'
building '/nix/store/albxgsjy52ycykwnhcynsmkkpbqagx7s-hosts.drv'
building '/nix/store/r579j5ndqk7dljywsh8yrmrzyy3zpfsa-hosts.drv'
building '/nix/store/mfl304f2pxh5y9kv0by9v81q6p554871-firewall-reload.drv'
building '/nix/store/7v207imi630ddc32q7kzm32avqcyhcg7-unit-systemd-resolved.service.drv'
building '/nix/store/6y3r1scm1bw4f661g6gyr5gs9kahsxcp-dm-send-dns.drv' on 'ssh-ng://builder@build-x86-01.clan.lol'
building '/nix/store/0vmzdbjs7dln9vv003cr49r2fhb6wbp8-dm.toml.drv'
building '/nix/store/6k3k79dnc2ixfsq68p6jk75ynrb2yrvl-dm.toml.drv'
building '/nix/store/wd1n19idiilglr8j803pbv3r5k9iqvbq-vars-check-dm-dns.drv'
building '/nix/store/2wnj6ksszsvqlhr8s8qj8wlwkb4n6kxy-users-groups.json.drv'
dm.toml> structuredAttrs is enabled
dm.toml> structuredAttrs is enabled
unit-systemd-resolved.service> structuredAttrs is enabled
building '/nix/store/sm5hm41x31p3m9y15g3lahd4zpmkbxvk-unit-firewall.service.drv'
vars-check-dm-dns> Running vars check using Nix-based executor...
vars-check-dm-dns> ✓ All vars checks completed successfully
building '/nix/store/6hfidg6cvmdmic08cpwnqq4fdpg9d6fi-X-Restart-Triggers-data-mesher.drv'
building '/nix/store/9r2nc09byvf0f5j71xga2cahsfdb5l12-X-Restart-Triggers-data-mesher.drv'
unit-firewall.service> structuredAttrs is enabled
building '/nix/store/xciwjp8rhyqfkvx6ngidypgghs283ndw-system-path.drv'
building '/nix/store/h1x6k1j420yp5fkr53ymqcr1s78vbdd0-unit-script-unbound-pre-start.drv'
building '/nix/store/51ws0sjyngq44nvh82lqgrpy9i1hljx9-unit-unbound-reload-zones.service.drv'
building '/nix/store/bvr8amqmwy350rkdmxn3fd0q94s2v0cs-decrypt-age-secrets.drv'
building '/nix/store/j8nxz2cmgir79xs7cqb0jr87aba34cf8-decrypt-age-secrets.drv'
system-path> structuredAttrs is enabled
unit-unbound-reload-zones.service> structuredAttrs is enabled
building '/nix/store/ad6airxm3r48vzsq75a4qp7hv1xb7wpk-unit-data-mesher.service.drv'
building '/nix/store/yh2bc6x986hwd996fic0zrc1gl05nhax-unit-data-mesher.service.drv'
building '/nix/store/9r5ns9kcagnrc32bzy56rz0yychicwsp-unit-unbound.service.drv'
building '/nix/store/d0r78mv551vk7vyc6w02dz6cmiw5a5yq-unit-unbound.service.drv'
system-path> created 1734 symlinks in user environment
unit-data-mesher.service> structuredAttrs is enabled
unit-data-mesher.service> structuredAttrs is enabled
unit-unbound.service> structuredAttrs is enabled
building '/nix/store/bp637mmra1sdfhpi3my0b5yxr7biqknc-dry-activate.drv'
building '/nix/store/jwfxnjfjqnj8q1k0f8fdkwv9vigqqk8x-dry-activate.drv'
unit-unbound.service> structuredAttrs is enabled
building '/nix/store/96r9vvffa7z9jqihl9f0brcf4n8wy2bi-dbus-1.drv'
building '/nix/store/6zvk8rzcz0fwbmxr51rd47nyibfwpcs7-X-Restart-Triggers-dbus-broker.drv'
building '/nix/store/5zli8fn1drvn3kbabzxwdjkbjz3pg1aw-unit-dbus-broker.service.drv'
building '/nix/store/hi057f63zvz15xfyqd6cffkhjv0myr5d-unit-dbus-broker.service.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/gnq0c4gs9822cpyzsia10z5vl0qwvh7l-system-units.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/ac0gp8ra1zlj4f3rc73rr67py7vv11j7-user-units.drv'
building '/nix/store/hm6zsl6gx95z4x1b5azcwcij185x9kwi-etc.drv'
building '/nix/store/yd54386rn153q8iirs7yiz8lrv2615n6-activate.drv'
building '/nix/store/giv2amg80g02hgpx92g55cy4bclsnw25-nixos-system-client-test.drv'
nixos-system-client-test> structuredAttrs is enabled
building '/nix/store/7ni49pxh7jmbzy3719i3r97qjn38g4n8-run-client-nspawn.drv'
building '/nix/store/6y3r1scm1bw4f661g6gyr5gs9kahsxcp-dm-send-dns.drv'
building '/nix/store/pc7w56kfm4930hpg4z7zqsw50vcicwls-system-path.drv'
system-path> structuredAttrs is enabled
system-path> created 1735 symlinks in user environment
building '/nix/store/rklghdsnkv2xvn92ykgflivqwqs1lb9h-dbus-1.drv'
building '/nix/store/9mbxqvihfhd285z7ps1abn288d2walad-X-Restart-Triggers-dbus-broker.drv'
building '/nix/store/dssfbqabaxlm47g7p8ggvia3wsc6v8zb-unit-dbus-broker.service.drv'
building '/nix/store/zkfhkar8wpi47306ff3d913c7n9flj5r-unit-dbus-broker.service.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/2jr4qhaprxvp9b74bxaxirw1h8x60nwb-user-units.drv'
unit-dbus-broker.service> structuredAttrs is enabled
building '/nix/store/zh9z6wv850rvnf6wpfdblbqhss1hb3qk-system-units.drv'
building '/nix/store/3n34h4534qmair6srz4czqxp845rr9dx-etc.drv'
building '/nix/store/1j66ddcr6rdaqs82401l9i1yvds86kyr-activate.drv'
building '/nix/store/49r3y9ciklhj49p7id575mkr937k6lbl-nixos-system-server-test.drv'
nixos-system-server-test> structuredAttrs is enabled
building '/nix/store/dhmrf2knwchgs46ij4zd5dccfw4rni25-run-server-nspawn.drv'
building '/nix/store/w7pyg1skn9qc02r757qdyqvq68v93544-driverConfiguration.json.drv'
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/x5lhgmx28manzz5dzinwc230z2ds3rmw-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/2k506in99iany1cyihy0nvjng4r8xfkj-container-test-run-dm-dns.drv' on 'ssh-ng://builder@build-x86-01.clan.lol'
building '/nix/store/2k506in99iany1cyihy0nvjng4r8xfkj-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(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> 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> 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 server on /build/vm-state-server.
container-test-run-dm-dns> ░ Spawning container client on /build/vm-state-client.
container-test-run-dm-dns> server # [7639639.875654] server systemd-journald[96]: Journal started
container-test-run-dm-dns> client # [7639639.874909] client systemd-journald[87]: Journal started
container-test-run-dm-dns> server # [7639639.875680] server systemd-journald[96]: Runtime Journal (/run/log/journal/79262bfa0cee41e4b496b469e9aa6284) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> client # [7639639.874935] client systemd-journald[87]: Runtime Journal (/run/log/journal/40710e273dc543c1bfa019f5c274255a) is 8M, max 3.7G, 3.7G free.
container-test-run-dm-dns> server # [7639639.879808] server systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> client # [7639639.875333] client systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-dm-dns> server # [7639639.880160] server systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> client # [7639639.879539] client systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-dm-dns> server # [7639639.880442] server systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> client # [7639639.879887] client systemd[1]: Starting Network Name Resolution...
container-test-run-dm-dns> server # [7639639.885518] server systemd-journald[96]: Time spent on flushing to /var/log/journal/79262bfa0cee41e4b496b469e9aa6284 is 1.043ms for 5 entries.
container-test-run-dm-dns> client # [7639639.880174] client systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-dm-dns> server # [7639639.885518] server systemd-journald[96]: System Journal (/var/log/journal/79262bfa0cee41e4b496b469e9aa6284) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> client # [7639639.884032] client systemd-journald[87]: Time spent on flushing to /var/log/journal/40710e273dc543c1bfa019f5c274255a is 956us for 6 entries.
container-test-run-dm-dns> server # [7639639.888598] server systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> client # [7639639.884032] client systemd-journald[87]: System Journal (/var/log/journal/40710e273dc543c1bfa019f5c274255a) is 8M, max 4G, 3.9G free.
container-test-run-dm-dns> server # [7639639.888947] server systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> client # [7639639.888625] client systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-dm-dns> server # [7639639.889003] server systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> client # [7639639.888777] client systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> server # [7639639.889437] server systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> client # [7639639.889101] client systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-dm-dns> server # [7639639.889463] server systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [7639639.889153] client systemd[1]: Reached target Local File Systems.
container-test-run-dm-dns> server # [7639639.889899] server systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> client # [7639639.889620] client systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-dm-dns> server # [7639639.889915] server systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> client # [7639639.889645] client systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [7639639.890547] server systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-dm-dns> client # [7639639.890032] client systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-dm-dns> server # [7639639.890909] server systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> client # [7639639.890386] client systemd[1]: Starting Create System Files and Directories...
container-test-run-dm-dns> server # [7639639.899953] server systemd-tmpfiles[136]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> client # [7639639.890401] client systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-dm-dns> server # [7639639.900110] server systemd-tmpfiles[136]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [7639639.900346] client systemd-tmpfiles[125]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-dm-dns> server # [7639639.900209] server systemd-tmpfiles[136]: fchmod() of /var/log/journal/79262bfa0cee41e4b496b469e9aa6284 failed: Operation not permitted
container-test-run-dm-dns> client # [7639639.900488] client systemd-tmpfiles[125]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [7639639.900358] server systemd-tmpfiles[136]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> client # [7639639.900586] client systemd-tmpfiles[125]: fchmod() of /var/log/journal/40710e273dc543c1bfa019f5c274255a failed: Operation not permitted
container-test-run-dm-dns> server # [7639639.901005] server systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> client # [7639639.900735] client systemd-tmpfiles[125]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-dm-dns> server # [7639639.901443] server systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> client # [7639639.901650] client systemd[1]: Finished Create System Files and Directories.
container-test-run-dm-dns> server # [7639639.901761] server systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> client # [7639639.902208] client systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-dm-dns> server # [7639639.907257] server systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> client # [7639639.902512] client systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-dm-dns> server # [7639639.913330] server systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> client # [7639639.908676] client systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-dm-dns> server # [7639639.913773] server systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> server # [7639639.918767] server systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> client # [7639639.915128] client systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-dm-dns> server # [7639639.983121] server systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> client # [7639639.915760] client systemd[1]: Starting Update is Completed...
container-test-run-dm-dns> server # [7639639.983357] server systemd[1]: Finished Firewall.
container-test-run-dm-dns> client # [7639639.921787] client systemd[1]: Finished Update is Completed.
container-test-run-dm-dns> server # [7639639.983918] server systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> client # [7639639.983132] client systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-dm-dns> server # [7639639.984117] server systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> client # [7639639.983369] client systemd[1]: Finished Firewall.
container-test-run-dm-dns> server # [7639639.984636] server systemd[1]: Starting Network Management...
container-test-run-dm-dns> client # [7639639.983757] client systemd[1]: Reached target Preparation for Network.
container-test-run-dm-dns> server # [7639640.234528] server systemd-networkd[214]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [7639640.234632] server systemd-networkd[214]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> client # [7639639.983934] client systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-dm-dns> server # [7639640.239782] server systemd-networkd[214]: /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 # [7639639.984553] client systemd[1]: Starting Network Management...
container-test-run-dm-dns> server # [7639640.239945] server systemd-networkd[214]: /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 # [7639640.234501] client systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [7639640.240018] server systemd-networkd[214]: lo: Link UP
container-test-run-dm-dns> server # [7639640.240023] server systemd-networkd[214]: lo: Gained carrier
container-test-run-dm-dns> client # [7639640.234582] client systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-dm-dns> server # [7639640.240171] server systemd-networkd[214]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> client # [7639640.239597] client systemd-networkd[205]: /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 # [7639640.239744] client systemd-networkd[205]: /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 # [7639640.240425] server systemd[1]: Started Network Management.
container-test-run-dm-dns> client # [7639640.239822] client systemd-networkd[205]: lo: Link UP
container-test-run-dm-dns> server # [7639640.240459] server systemd-networkd[214]: eth1: Link UP
container-test-run-dm-dns> client # [7639640.239824] client systemd-networkd[205]: lo: Gained carrier
container-test-run-dm-dns> client # [7639640.240017] client systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-dm-dns> server # [7639640.240597] server systemd-networkd[214]: eth1: Gained carrier
container-test-run-dm-dns> client # [7639640.240261] client systemd[1]: Started Network Management.
container-test-run-dm-dns> server # [7639640.240954] server systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> client # [7639640.240312] client systemd-networkd[205]: eth1: Link UP
container-test-run-dm-dns> server # [7639640.267224] server systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> client # [7639640.240487] client systemd-networkd[205]: eth1: Gained carrier
container-test-run-dm-dns> server # [7639640.338450] server systemd-resolved[118]: Positive Trust Anchors:
container-test-run-dm-dns> client # [7639640.240908] client systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-dm-dns> server # [7639640.338460] server systemd-resolved[118]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> client # [7639640.267237] client systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-dm-dns> server # [7639640.338463] server systemd-resolved[118]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> client # [7639640.343300] client systemd-resolved[108]: Positive Trust Anchors:
container-test-run-dm-dns> server # [7639640.338486] server systemd-resolved[118]: 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 # [7639640.343306] client systemd-resolved[108]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-dm-dns> server # [7639640.350920] server systemd-resolved[118]: Using system hostname 'server'.
container-test-run-dm-dns> client # [7639640.343309] client systemd-resolved[108]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-dm-dns> server # [7639640.351865] server systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> client # [7639640.343325] client systemd-resolved[108]: 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 # [7639640.351920] server systemd[1]: Reached target Network.
container-test-run-dm-dns> client # [7639640.353680] client systemd-resolved[108]: Using system hostname 'client'.
container-test-run-dm-dns> server # [7639640.351958] server systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> client # [7639640.354493] client systemd[1]: Started Network Name Resolution.
container-test-run-dm-dns> server # [7639640.352015] server systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> server # [7639640.352033] server systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> client # [7639640.354539] client systemd[1]: Reached target Network.
container-test-run-dm-dns> server # [7639640.352050] server systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> client # [7639640.354581] client systemd[1]: Reached target System Initialization.
container-test-run-dm-dns> server # [7639640.352063] server systemd[1]: Reached target Path Units.
container-test-run-dm-dns> client # [7639640.354634] client systemd[1]: Started Watch for zone file changes.
container-test-run-dm-dns> server # [7639640.352085] server systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> client # [7639640.354649] client systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-dm-dns> server # [7639640.352172] server systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> client # [7639640.354665] client systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-dm-dns> server # [7639640.352240] server systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> client # [7639640.354678] client systemd[1]: Reached target Path Units.
container-test-run-dm-dns> server # [7639640.352308] server systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> client # [7639640.354698] client systemd[1]: Reached target Timer Units.
container-test-run-dm-dns> server # [7639640.352317] server systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> client # [7639640.354775] client systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-dm-dns> server # [7639640.352336] server systemd[1]: Reached target Basic System.
container-test-run-dm-dns> client # [7639640.354834] client systemd[1]: Listening on Nix Daemon Socket.
container-test-run-dm-dns> server # [7639640.353076] server systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> client # [7639640.354903] client systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-dm-dns> server # [7639640.353411] server systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> client # [7639640.354912] client systemd[1]: Reached target Socket Units.
container-test-run-dm-dns> server # [7639640.353788] server systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> client # [7639640.354934] client systemd[1]: Reached target Basic System.
container-test-run-dm-dns> server # [7639640.354505] server systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> server # [7639640.386792] server systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> server # [7639640.441224] server nsncd[221]: Aug 27 20:08:17.806 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> server # [7639640.441298] server systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> server # [7639640.441360] server systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> server # [7639640.442111] server systemd[1]: Starting User Login Management...
container-test-run-dm-dns> server # [7639640.442415] server systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> server # [7639640.465108] server systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> server # [7639640.465652] server systemd[1]: Started Console Getty.
container-test-run-dm-dns> server # [7639640.465674] server systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> server # [7639640.465682] server systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> client # [7639640.377154] client systemd[1]: Starting data mesher daemon...
container-test-run-dm-dns> client # [7639640.377563] client systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-dm-dns> client # [7639640.377926] client systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-dm-dns> client # [7639640.378659] client systemd[1]: Starting D-Bus System Message Bus...
container-test-run-dm-dns> client # [7639640.387955] client systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-dm-dns> client # [7639640.440840] client nsncd[212]: Aug 27 20:08:17.806 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-dm-dns> client # [7639640.440884] client systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-dm-dns> client # [7639640.440922] client systemd[1]: Reached target User and Group Name Lookups.
container-test-run-dm-dns> client # [7639640.441476] client systemd[1]: Starting User Login Management...
container-test-run-dm-dns> client # [7639640.441812] client systemd[1]: Starting Permit User Sessions...
container-test-run-dm-dns> client # [7639640.465655] client systemd[1]: Finished Permit User Sessions.
container-test-run-dm-dns> client # [7639640.466199] client systemd[1]: Started Console Getty.
container-test-run-dm-dns> client # [7639640.466218] client systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-dm-dns> client # [7639640.466229] client systemd[1]: Reached target Login Prompts.
container-test-run-dm-dns> server # [7639640.500277] server dbus-broker-launch[222]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> server # [7639640.500813] server dbus-broker-launch[222]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> server # [7639640.500813] server dbus-broker-launch[222]: Invalid user-name in /nix/store/fdsrnlxxrgn9v0pjlhnp5pnpi1sxms0n-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> server # [7639640.501185] server systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> server # [7639640.504673] server dbus-broker-launch[222]: Ready
container-test-run-dm-dns> server # [7639640.664547] server data-mesher[219]: time=2026-08-27T20:08:18.030Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> server # [7639640.664845] server data-mesher[219]: time=2026-08-27T20:08:18.030Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx: [/dns/client.test/tcp/7946]} {12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK
container-test-run-dm-dns> server # [7639640.664866] server data-mesher[219]: time=2026-08-27T20:08:18.030Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> server # [7639640.667103] server data-mesher[219]: time=2026-08-27T20:08:18.032Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> server # [7639640.667222] server data-mesher[219]: time=2026-08-27T20:08:18.032Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> server # [7639640.669209] server data-mesher[219]: time=2026-08-27T20:08:18.034Z level=INFO msg="libp2p host created" peer_id=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK 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 # [7639640.669234] server data-mesher[219]: time=2026-08-27T20:08:18.034Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> server # [7639640.669234] server data-mesher[219]: time=2026-08-27T20:08:18.034Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> server # [7639640.669234] server data-mesher[219]: time=2026-08-27T20:08:18.034Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> server # [7639640.669234] server data-mesher[219]: time=2026-08-27T20:08:18.034Z level=INFO msg="starting server"
container-test-run-dm-dns> server # [7639640.669317] server data-mesher[219]: time=2026-08-27T20:08:18.035Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> server # [7639640.669354] server data-mesher[219]: time=2026-08-27T20:08:18.035Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> server # [7639640.669384] server data-mesher[219]: time=2026-08-27T20:08:18.035Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> server # [7639640.671611] server data-mesher[219]: time=2026-08-27T20:08:18.037Z level=INFO msg="peer connected" peer_id=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-dm-dns> server # [7639640.700984] server data-mesher[219]: time=2026-08-27T20:08:18.066Z level=INFO msg="peer connected" peer_id=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx remote_addr=/ip4/192.168.1.1/tcp/39122
container-test-run-dm-dns> client # [7639640.501165] client dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-dm-dns> client # [7639640.501540] client dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'
container-test-run-dm-dns> client # [7639640.501540] client dbus-broker-launch[213]: Invalid user-name in /nix/store/53f3jvfszgkfa84m0x2pwb98byq9qac1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-dm-dns> client # [7639640.501770] client systemd[1]: Started D-Bus System Message Bus.
container-test-run-dm-dns> client # [7639640.504932] client dbus-broker-launch[213]: Ready
container-test-run-dm-dns> client # [7639640.665698] client data-mesher[210]: time=2026-08-27T20:08:18.031Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-dm-dns> client # [7639640.666925] client data-mesher[210]: time=2026-08-27T20:08:18.032Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx: [/dns/client.test/tcp/7946]} {12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK: [/dns/server.test/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx
container-test-run-dm-dns> client # [7639640.666925] client data-mesher[210]: time=2026-08-27T20:08:18.032Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-dm-dns> client # [7639640.667570] client data-mesher[210]: time=2026-08-27T20:08:18.033Z level=INFO msg="checking file integrity"
container-test-run-dm-dns> client # [7639640.667646] client data-mesher[210]: time=2026-08-27T20:08:18.033Z level=INFO msg="file integrity check complete"
container-test-run-dm-dns> client # [7639640.669341] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="libp2p host created" peer_id=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx 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 # [7639640.669365] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-dm-dns> client # [7639640.669365] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-dm-dns> client # [7639640.669365] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-dm-dns> client # [7639640.669365] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="starting server"
container-test-run-dm-dns> client # [7639640.669411] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-dm-dns> client # [7639640.669518] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-dm-dns> client # [7639640.669585] client data-mesher[210]: time=2026-08-27T20:08:18.035Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-dm-dns> client # [7639640.671821] client data-mesher[210]: time=2026-08-27T20:08:18.037Z level=INFO msg="peer connected" peer_id=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-dm-dns> client # [7639640.700813] client data-mesher[210]: time=2026-08-27T20:08:18.066Z level=INFO msg="peer connected" peer_id=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-dm-dns> client # [7639640.751267] client systemd-logind[230]: New seat seat0.
container-test-run-dm-dns> client # [7639640.751353] client systemd[1]: Started User Login Management.
container-test-run-dm-dns> client # [7639640.752014] client systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> client # [7639640.782560] client systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> client # [7639640.782601] client systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> client # [7639640.868150] client systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> server # [7639640.750733] server systemd-logind[239]: New seat seat0.
container-test-run-dm-dns> server # [7639640.750820] server systemd[1]: Started User Login Management.
container-test-run-dm-dns> server # [7639640.751690] server systemd[1]: Starting linger-users.service...
container-test-run-dm-dns> server # [7639640.782245] server systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-dm-dns> server # [7639640.782333] server systemd[1]: Finished linger-users.service.
container-test-run-dm-dns> server # [7639640.868664] server systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-dm-dns> client # [7639642.237088] client systemd-networkd[205]: eth1: Gained IPv6LL
container-test-run-dm-dns> server # [7639642.237110] server systemd-networkd[214]: eth1: Gained IPv6LL
container-test-run-dm-dns> server: still waiting for container 'server' to reach ready state...
container-test-run-dm-dns> client # [7639650.672056] client data-mesher[210]: time=2026-08-27T20:08:28.037Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> client # [7639650.672374] client data-mesher[210]: time=2026-08-27T20:08:28.037Z level=DEBUG msg="initiating state exchange" peer=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK timeout=5s
container-test-run-dm-dns> client # [7639650.672417] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="received state sync from peer" peer=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK
container-test-run-dm-dns> client # [7639650.672436] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="merging remote state" peer=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK
container-test-run-dm-dns> client # [7639650.672480] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="merging remote state" peer=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK
container-test-run-dm-dns> client # [7639650.672480] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="state exchange complete" peer=12D3KooWPQzqtkNAfhxMNAhnbnigGKWG3Eum76Krm6JxE9YAwUPK timeout=5s
container-test-run-dm-dns> client # [7639650.672518] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="server started"
container-test-run-dm-dns> client # [7639650.672563] client data-mesher[210]: time=2026-08-27T20:08:28.038Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> client # [7639650.672633] client systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> client # [7639650.673409] client systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> server # [7639650.672209] server data-mesher[219]: time=2026-08-27T20:08:28.037Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-dm-dns> server # [7639650.672209] server data-mesher[219]: time=2026-08-27T20:08:28.037Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx timeout=5s
container-test-run-dm-dns> server # [7639650.672507] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="received state sync from peer" peer=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx
container-test-run-dm-dns> server # [7639650.672507] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="merging remote state" peer=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx
container-test-run-dm-dns> server # [7639650.672507] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="merging remote state" peer=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx
container-test-run-dm-dns> server # [7639650.672507] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="state exchange complete" peer=12D3KooWCo7BDWiHsCyJCDSdBLohKWQZ6zkQ6s5HMWUEXQ3Pzwqx timeout=5s
container-test-run-dm-dns> server # [7639650.672507] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="server started"
container-test-run-dm-dns> server # [7639650.672630] server data-mesher[219]: time=2026-08-27T20:08:28.038Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-dm-dns> server # [7639650.672634] server systemd[1]: Started data mesher daemon.
container-test-run-dm-dns> server # [7639650.673572] server systemd[1]: Starting Unbound recursive Domain Name Server...
container-test-run-dm-dns> client # [7639651.033461] client unbound-pre-start[262]: Root anchor updated!
container-test-run-dm-dns> client # [7639651.041177] client unbound-pre-start[266]: setup in directory /var/lib/unbound
container-test-run-dm-dns> server # [7639651.042904] server unbound-pre-start[271]: Root anchor updated!
container-test-run-dm-dns> server # [7639651.049592] server unbound-pre-start[275]: setup in directory /var/lib/unbound
container-test-run-dm-dns> client # [7639651.301050] client unbound-pre-start[275]: Certificate request self-signature ok
container-test-run-dm-dns> client # [7639651.301050] client unbound-pre-start[275]: subject=CN=unbound-control
container-test-run-dm-dns> client # [7639651.305835] client unbound-pre-start[266]: removing artifacts
container-test-run-dm-dns> client # [7639651.306745] client unbound-pre-start[266]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> server # [7639651.488488] server unbound-pre-start[284]: Certificate request self-signature ok
container-test-run-dm-dns> server # [7639651.488488] server unbound-pre-start[284]: subject=CN=unbound-control
container-test-run-dm-dns> server # [7639651.493565] server unbound-pre-start[275]: removing artifacts
container-test-run-dm-dns> server # [7639651.494580] server unbound-pre-start[275]: Setup success. Certificates created. Enable in unbound.conf file to use
container-test-run-dm-dns> server: (finished: waiting for unit unbound.service, in 12.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/q1220y1r1zpkahb0n8kan0d8h5rsg8f6-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/q1220y1r1zpkahb0n8kan0d8h5rsg8f6-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/y5iz7dc0kz6hbr148qpw2853k0hygs26-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/y5iz7dc0kz6hbr148qpw2853k0hygs26-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39
container-test-run-dm-dns> server # [7639651.828848] server unbound[289]: [289:0] notice: init module 0: validator
container-test-run-dm-dns> server # [7639651.828986] server unbound[289]: [289:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [7639651.832199] server unbound[289]: [289:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server # [7639651.832272] server systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> server # [7639651.832400] server systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> server # [7639651.832466] server systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> server # [7639651.833305] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> server # [7639651.856813] server unbound[289]: [289:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> server # [7639651.856908] server unbound-control[292]: ok
container-test-run-dm-dns> server # [7639651.857040] server unbound[289]: [289: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 # [7639651.857043] server unbound[289]: [289:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> server # [7639651.857554] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [7639651.857650] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [7639651.857757] server systemd[1]: Startup finished in 12.212s.
container-test-run-dm-dns> server # [7639651.857935] server unbound[289]: [289:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> server # [7639651.858559] server unbound[289]: [289:0] notice: init module 0: validator
container-test-run-dm-dns> server # [7639651.858604] server unbound[289]: [289:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [7639651.861339] server unbound[289]: [289:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server # [7639652.053818] server data-mesher[219]: time=2026-08-27T20:08:29.419Z level=INFO msg=http_request uri=/files/dns/cnames status=204
container-test-run-dm-dns> server # [7639652.054879] server systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> client # [7639651.672702] client unbound[280]: [280:0] notice: init module 0: validator
container-test-run-dm-dns> client # [7639651.672841] client unbound[280]: [280:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [7639651.676089] client unbound[280]: [280:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> client # [7639651.676162] client systemd[1]: Started Unbound recursive Domain Name Server.
container-test-run-dm-dns> client # [7639651.676339] client systemd[1]: Reached target Multi-User System.
container-test-run-dm-dns> client # [7639651.676419] client systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-dm-dns> client # [7639651.677055] client systemd[1]: Starting Reload unbound zone configuration...
container-test-run-dm-dns> client # [7639651.704763] client unbound[280]: [280:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> client # [7639651.704858] client unbound-control[283]: ok
container-test-run-dm-dns> client # [7639651.704984] client unbound[280]: [280: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 # [7639651.704988] client unbound[280]: [280:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> client # [7639651.705478] client systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> client # [7639651.705589] client systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> client # [7639651.705714] client systemd[1]: Startup finished in 12.066s.
container-test-run-dm-dns> client # [7639651.705848] client unbound[280]: [280:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> client # [7639651.706404] client unbound[280]: [280:0] notice: init module 0: validator
container-test-run-dm-dns> client # [7639651.706437] client unbound[280]: [280:0] notice: init module 1: iterator
container-test-run-dm-dns> client # [7639651.709474] client unbound[280]: [280:0] info: start of service (unbound 1.26.0).
container-test-run-dm-dns> server # [7639652.088183] server unbound[289]: [289:0] info: service stopped (unbound 1.26.0).
container-test-run-dm-dns> server # [7639652.088311] server unbound-control[316]: ok
container-test-run-dm-dns> server # [7639652.088539] server unbound[289]: [289: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 # [7639652.088544] server unbound[289]: [289:0] info: server stats for thread 0: requestlist max 1 avg 1 exceeded 0 jostled 0
container-test-run-dm-dns> server # [7639652.088868] server systemd[1]: unbound-reload-zones.service: Deactivated successfully.
container-test-run-dm-dns> server # [7639652.088980] server systemd[1]: Finished Reload unbound zone configuration.
container-test-run-dm-dns> server # [7639652.089105] server unbound[289]: [289:0] notice: Restart of unbound 1.26.0.
container-test-run-dm-dns> server # [7639652.089542] server unbound[289]: [289:0] notice: init module 0: validator
container-test-run-dm-dns> server # [7639652.089570] server unbound[289]: [289:0] notice: init module 1: iterator
container-test-run-dm-dns> server # [7639652.091301] server unbound[289]: [289:0] info: start of service (unbound 1.26.0).
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 13.71 seconds)
container-test-run-dm-dns> test script finished in 14.12s
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> Container server terminated by signal KILL.
container-test-run-dm-dns> (finished: cleanup, in 0.18 seconds)

post-build step Upload to niks3: ok
time=2026-08-27T20:08:31.320Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)"
time=2026-08-27T20:08:31.701Z level=INFO msg="Uploading 1 narinfos"
time=2026-08-27T20:08:32.154Z level=INFO msg="Upload complete. (907ms)"