these 74 derivations will be built: /nix/store/5kyjwyrwrj43y9d46bz4fl4wrlzjfv17-dm.toml.drv /nix/store/gyi5mp83l35x3l93m01adqj9fbizp7kp-system-path.drv /nix/store/a08sfxk016n1sb67s78kp1g346m3np8n-dbus-1.drv /nix/store/bqvq6krrmk04afjbrgr6dzcp7cinq83w-vars-check-dm-wireguard-star.drv /nix/store/6fbva1ifs9kmkizsb9q3q0n9nd4l3r5s-extra-hosts.drv /nix/store/hf2wfbxj29z5zwhzspyv4rr83hzjq59i-hosts.drv /nix/store/k2ficqjvd6xlffzjaggka7c74ky36ar5-unit-40-wg-star.netdev.drv /nix/store/0v95w5pkm73jk7b0p7x68135x8wa39g0-X-Restart-Triggers-dbus-broker.drv /nix/store/b6w0r6z1abm0dd5n6dmm312f7hc9vjni-unit-dbus-broker.service.drv /nix/store/ldf302gbh4c3b06cpx262rgs83zlsjnm-user-units.drv /nix/store/nqzcg150ch2lw0k9vxcls8zpb3m1qidj-unit-40-wg-star.network.drv /nix/store/kwlx9prf9jsj9mndjn5lmkdphdz7gv4p-unit-script-dm-wg-star-wg-star-reconfig-start.drv /nix/store/471r401rj9cnl4m4k271yfs9wzcz0xzm-unit-dm-wg-star-wg-star-reconfig.service.drv /nix/store/j2drzn8q9ixm1bpwiqm0afp4x7x917bh-X-Restart-Triggers-data-mesher.drv /nix/store/4qb89i9ym7spmblgwv2c4pis86lx8nvv-unit-data-mesher.service.drv /nix/store/6bg3lnndfr6m24njzrd8rgzj1l44zqm4-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/5dvkgip2a90jgsxd9r116062zjx7fknk-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/6c1km05nrpyp87hjjxg9rwfxkvm1yrc5-unit-dm-wg-star-wg-star-reconfig.path.drv /nix/store/7gkn9ydimv2xva6qp22lkb63q25wpap7-unit-dm-wg-star-wg-star-publish.timer.drv /nix/store/8bqmx78f358rxisi5zqwh73xzric5685-unit-dbus-broker.service.drv /nix/store/2hy4gdzawlfbvklpd5yzyjxp8h51j5w0-X-Reload-Triggers-systemd-networkd.drv /nix/store/bgqx6lfy10jhi1a3yc15gsyadpr9jx5d-X-Restart-Triggers-systemd-networkd.drv /nix/store/gz1in3hswzay16hlm589z9x5imjnc263-unit-systemd-networkd.service.drv /nix/store/rrxbz2by5qgrcj0bfv783a6ckwwbq2sw-system-units.drv /nix/store/8bzx6rhyayzpq96ignsa32ilrqkw9hrl-etc.drv /nix/store/6774fp73rs0xxfd41vnyb1nrcwmn6k5w-decrypt-age-secrets.drv /nix/store/9c5i6mhb66ybhcaqhi5ll4hzm9d1c2nc-dry-activate.drv /nix/store/xjq7kdzld3gn2nh3lnn067xfiipbs2y0-activate.drv /nix/store/06s6shf1xpf7rwiix881wvx4pxglkgx5-nixos-system-peer1-test.drv /nix/store/ysaipmhbxp27rrbkhc4i9f5kx6w3zcm1-unit-40-wg-star.network.drv /nix/store/z1x4m3fqb1sslwiqd137rqcvn5pf9bwa-X-Reload-Triggers-systemd-networkd.drv /nix/store/07ik278cc3gp86p1wsia2qsxm89v854n-unit-systemd-networkd.service.drv /nix/store/0wzk6gsarbx3hp0h3qfmm34y477sxjj0-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/pxnrrb3w7yacb72zzhlx2h45cc1lkfa8-dm.toml.drv /nix/store/sildkyvgdv5g8bxi7ldn81nfm0r4r7jq-X-Restart-Triggers-data-mesher.drv /nix/store/1afg5bypz87xkgiwb9vf8pwlz1wpw8c9-unit-data-mesher.service.drv /nix/store/icvlsxa4hbvpsbfy6d62xrryxdgzpcpa-test-script.drv /nix/store/2kwz12ll8bjcmf86ksdm52mggi6vm3ai-decrypt-age-secrets.drv /nix/store/28j4z4c1zvq45cz9c1fb8hrzkinclylh-dm.toml.drv /nix/store/c9y0cjk3bgg32mi4q3v4094hgbw7cdag-hosts.drv /nix/store/h9rm47w1siq3sc6vprf2f0d5nd3c2pv7-X-Restart-Triggers-data-mesher.drv /nix/store/4pxxigyrv6p3fg9wbfgd29x1p8vlbssb-unit-data-mesher.service.drv /nix/store/y5ik1svzjp41l9mzg48km9dylgynjnyw-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/mv42qlhjcwww8rs8dvlid53paj97dmyz-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/i283vr09whx6w4fhlfr2370fzy077x4d-system-units.drv /nix/store/ag7wadblw0iyp69pd4fjnb4grsq4jvl4-etc.drv /nix/store/9miap1jfh30cx3gd6izgbhrc4kcak589-activate.drv /nix/store/cp619z2sm82rcaa9szjhal68rvqrlcwd-dry-activate.drv /nix/store/1zchg1m7knxxvcnwsbb6q3h9zlwgvsq4-nixos-system-peer2-test.drv /nix/store/78rr33bhb1lim5brjy30gpph4rkwmdlc-run-peer2-nspawn.drv /nix/store/9wbnr9h9jp9a1716flicjkhxnhvw5ln9-run-peer1-nspawn.drv /nix/store/bkn8j640lf5f308i960w0v2rf7sapbcz-hosts.drv /nix/store/fai0r34qdqy1baws104g6234gmnsg3la-firewall-start.drv /nix/store/saknfvq2896lqhwf03kjsvxszh9zdawy-firewall-reload.drv /nix/store/6hspaw59afvsshcq1y3k4cipl6w8qr9r-unit-firewall.service.drv /nix/store/qxlxcj0qvbgpnl7108kddpjj9szxvraf-unit-script-dm-wg-star-wg-star-reconfig-start.drv /nix/store/9xygg1fdn89zqp0l0471vh3vlx63jbcy-unit-dm-wg-star-wg-star-reconfig.service.drv /nix/store/xbrshp0qlg6fy3m04cg20cv6757rxbpa-unit-40-wg-star.netdev.drv /nix/store/gxwsk311rkf7iph19kx2lhcs3bklxfaw-X-Restart-Triggers-systemd-networkd.drv /nix/store/zxhbbyk8fnz4ppmwi8yjl9njlh115njp-unit-40-wg-star.network.drv /nix/store/qh44w9zwyr0r8j123ap2q56ddzv70a5k-X-Reload-Triggers-systemd-networkd.drv /nix/store/if6hx8f6i8r6jz4qphy7q7gf5c8iacps-unit-systemd-networkd.service.drv /nix/store/nay2670c8sp1sn0zqxk3rh8s3vjaz30f-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/phiwk0259rdzqjl5lpn2lhpvcz4d8mhl-unit-dm-wg-star-wg-star-reconfig.path.drv /nix/store/jypplg7ac93sdn83isyrwkkrfzjzbp7s-system-units.drv /nix/store/4764l47y3j66l220kd8zss2m7fxnk1bm-etc.drv /nix/store/rmf9iv4j4in4151vjdhnjgkq536vvx74-decrypt-age-secrets.drv /nix/store/jyivl9xqzk18prs12gfbp42zfr8fy3ck-activate.drv /nix/store/sl9s8y0acyyvpg6mxnaqcly310lqcz39-dry-activate.drv /nix/store/kqfqn1x1bw6888kppp382m5kj4azdqbl-nixos-system-controller-test.drv /nix/store/msj2aq4cs87idzajwaa701mymc2l0rg5-run-controller-nspawn.drv /nix/store/vmvxn7pvi7r3n2llxpr7bc06cplpjkck-driverConfiguration.json.drv /nix/store/1hhb6yf7p6y1qdq2avx5mjm6zai1n9xd-nixos-test-driver-dm-wireguard-star.drv /nix/store/i6820xkbbdn2z7sdfb2sjla3nrc3wn3b-container-test-run-dm-wireguard-star.drv building '/nix/store/icvlsxa4hbvpsbfy6d62xrryxdgzpcpa-test-script.drv' building '/nix/store/gyi5mp83l35x3l93m01adqj9fbizp7kp-system-path.drv' building '/nix/store/k2ficqjvd6xlffzjaggka7c74ky36ar5-unit-40-wg-star.netdev.drv' building '/nix/store/xbrshp0qlg6fy3m04cg20cv6757rxbpa-unit-40-wg-star.netdev.drv' building '/nix/store/nqzcg150ch2lw0k9vxcls8zpb3m1qidj-unit-40-wg-star.network.drv' building '/nix/store/ysaipmhbxp27rrbkhc4i9f5kx6w3zcm1-unit-40-wg-star.network.drv' building '/nix/store/zxhbbyk8fnz4ppmwi8yjl9njlh115njp-unit-40-wg-star.network.drv' building '/nix/store/6fbva1ifs9kmkizsb9q3q0n9nd4l3r5s-extra-hosts.drv' building '/nix/store/7gkn9ydimv2xva6qp22lkb63q25wpap7-unit-dm-wg-star-wg-star-publish.timer.drv' building '/nix/store/6c1km05nrpyp87hjjxg9rwfxkvm1yrc5-unit-dm-wg-star-wg-star-reconfig.path.drv' system-path> structuredAttrs is enabled system-path> created 1731 symlinks in user environment unit-40-wg-star.netdev> structuredAttrs is enabled unit-40-wg-star.netdev> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.timer> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.path> structuredAttrs is enabled building '/nix/store/fai0r34qdqy1baws104g6234gmnsg3la-firewall-start.drv' building '/nix/store/phiwk0259rdzqjl5lpn2lhpvcz4d8mhl-unit-dm-wg-star-wg-star-reconfig.path.drv' building '/nix/store/0wzk6gsarbx3hp0h3qfmm34y477sxjj0-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/6bg3lnndfr6m24njzrd8rgzj1l44zqm4-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/y5ik1svzjp41l9mzg48km9dylgynjnyw-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/kwlx9prf9jsj9mndjn5lmkdphdz7gv4p-unit-script-dm-wg-star-wg-star-reconfig-start.drv' building '/nix/store/qxlxcj0qvbgpnl7108kddpjj9szxvraf-unit-script-dm-wg-star-wg-star-reconfig-start.drv' building '/nix/store/2hy4gdzawlfbvklpd5yzyjxp8h51j5w0-X-Reload-Triggers-systemd-networkd.drv' building '/nix/store/qh44w9zwyr0r8j123ap2q56ddzv70a5k-X-Reload-Triggers-systemd-networkd.drv' unit-dm-wg-star-wg-star-reconfig.path> structuredAttrs is enabled building '/nix/store/z1x4m3fqb1sslwiqd137rqcvn5pf9bwa-X-Reload-Triggers-systemd-networkd.drv' building '/nix/store/bgqx6lfy10jhi1a3yc15gsyadpr9jx5d-X-Restart-Triggers-systemd-networkd.drv' building '/nix/store/gxwsk311rkf7iph19kx2lhcs3bklxfaw-X-Restart-Triggers-systemd-networkd.drv' building '/nix/store/bkn8j640lf5f308i960w0v2rf7sapbcz-hosts.drv' building '/nix/store/c9y0cjk3bgg32mi4q3v4094hgbw7cdag-hosts.drv' building '/nix/store/hf2wfbxj29z5zwhzspyv4rr83hzjq59i-hosts.drv' building '/nix/store/a08sfxk016n1sb67s78kp1g346m3np8n-dbus-1.drv' building '/nix/store/bqvq6krrmk04afjbrgr6dzcp7cinq83w-vars-check-dm-wireguard-star.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/28j4z4c1zvq45cz9c1fb8hrzkinclylh-dm.toml.drv' building '/nix/store/5kyjwyrwrj43y9d46bz4fl4wrlzjfv17-dm.toml.drv' building '/nix/store/pxnrrb3w7yacb72zzhlx2h45cc1lkfa8-dm.toml.drv' building '/nix/store/saknfvq2896lqhwf03kjsvxszh9zdawy-firewall-reload.drv' building '/nix/store/5dvkgip2a90jgsxd9r116062zjx7fknk-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/mv42qlhjcwww8rs8dvlid53paj97dmyz-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/nay2670c8sp1sn0zqxk3rh8s3vjaz30f-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/471r401rj9cnl4m4k271yfs9wzcz0xzm-unit-dm-wg-star-wg-star-reconfig.service.drv' building '/nix/store/9xygg1fdn89zqp0l0471vh3vlx63jbcy-unit-dm-wg-star-wg-star-reconfig.service.drv' building '/nix/store/0v95w5pkm73jk7b0p7x68135x8wa39g0-X-Restart-Triggers-dbus-broker.drv' dm.toml> structuredAttrs is enabled dm.toml> structuredAttrs is enabled dm.toml> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.service> structuredAttrs is enabled building '/nix/store/07ik278cc3gp86p1wsia2qsxm89v854n-unit-systemd-networkd.service.drv' unit-systemd-networkd.service> structuredAttrs is enabled building '/nix/store/bqvq6krrmk04afjbrgr6dzcp7cinq83w-vars-check-dm-wireguard-star.drv' vars-check-dm-wireguard-star> Running vars check using Nix-based executor... vars-check-dm-wireguard-star> ✓ All vars checks completed successfully building '/nix/store/6hspaw59afvsshcq1y3k4cipl6w8qr9r-unit-firewall.service.drv' building '/nix/store/gz1in3hswzay16hlm589z9x5imjnc263-unit-systemd-networkd.service.drv' building '/nix/store/if6hx8f6i8r6jz4qphy7q7gf5c8iacps-unit-systemd-networkd.service.drv' building '/nix/store/h9rm47w1siq3sc6vprf2f0d5nd3c2pv7-X-Restart-Triggers-data-mesher.drv' building '/nix/store/j2drzn8q9ixm1bpwiqm0afp4x7x917bh-X-Restart-Triggers-data-mesher.drv' building '/nix/store/sildkyvgdv5g8bxi7ldn81nfm0r4r7jq-X-Restart-Triggers-data-mesher.drv' building '/nix/store/2kwz12ll8bjcmf86ksdm52mggi6vm3ai-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/6774fp73rs0xxfd41vnyb1nrcwmn6k5w-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/rmf9iv4j4in4151vjdhnjgkq536vvx74-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' unit-firewall.service> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled building '/nix/store/1afg5bypz87xkgiwb9vf8pwlz1wpw8c9-unit-data-mesher.service.drv' building '/nix/store/4pxxigyrv6p3fg9wbfgd29x1p8vlbssb-unit-data-mesher.service.drv' building '/nix/store/4qb89i9ym7spmblgwv2c4pis86lx8nvv-unit-data-mesher.service.drv' building '/nix/store/8bqmx78f358rxisi5zqwh73xzric5685-unit-dbus-broker.service.drv' building '/nix/store/b6w0r6z1abm0dd5n6dmm312f7hc9vjni-unit-dbus-broker.service.drv' unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/i283vr09whx6w4fhlfr2370fzy077x4d-system-units.drv' building '/nix/store/jypplg7ac93sdn83isyrwkkrfzjzbp7s-system-units.drv' building '/nix/store/rrxbz2by5qgrcj0bfv783a6ckwwbq2sw-system-units.drv' building '/nix/store/ldf302gbh4c3b06cpx262rgs83zlsjnm-user-units.drv' building '/nix/store/6774fp73rs0xxfd41vnyb1nrcwmn6k5w-decrypt-age-secrets.drv' building '/nix/store/9c5i6mhb66ybhcaqhi5ll4hzm9d1c2nc-dry-activate.drv' building '/nix/store/rmf9iv4j4in4151vjdhnjgkq536vvx74-decrypt-age-secrets.drv' building '/nix/store/2kwz12ll8bjcmf86ksdm52mggi6vm3ai-decrypt-age-secrets.drv' building '/nix/store/cp619z2sm82rcaa9szjhal68rvqrlcwd-dry-activate.drv' building '/nix/store/sl9s8y0acyyvpg6mxnaqcly310lqcz39-dry-activate.drv' building '/nix/store/ag7wadblw0iyp69pd4fjnb4grsq4jvl4-etc.drv' building '/nix/store/4764l47y3j66l220kd8zss2m7fxnk1bm-etc.drv' building '/nix/store/8bzx6rhyayzpq96ignsa32ilrqkw9hrl-etc.drv' building '/nix/store/9miap1jfh30cx3gd6izgbhrc4kcak589-activate.drv' building '/nix/store/1zchg1m7knxxvcnwsbb6q3h9zlwgvsq4-nixos-system-peer2-test.drv' building '/nix/store/jyivl9xqzk18prs12gfbp42zfr8fy3ck-activate.drv' nixos-system-peer2-test> structuredAttrs is enabled building '/nix/store/xjq7kdzld3gn2nh3lnn067xfiipbs2y0-activate.drv' building '/nix/store/kqfqn1x1bw6888kppp382m5kj4azdqbl-nixos-system-controller-test.drv' building '/nix/store/78rr33bhb1lim5brjy30gpph4rkwmdlc-run-peer2-nspawn.drv' nixos-system-controller-test> structuredAttrs is enabled building '/nix/store/06s6shf1xpf7rwiix881wvx4pxglkgx5-nixos-system-peer1-test.drv' building '/nix/store/msj2aq4cs87idzajwaa701mymc2l0rg5-run-controller-nspawn.drv' nixos-system-peer1-test> structuredAttrs is enabled building '/nix/store/9wbnr9h9jp9a1716flicjkhxnhvw5ln9-run-peer1-nspawn.drv' building '/nix/store/vmvxn7pvi7r3n2llxpr7bc06cplpjkck-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/1hhb6yf7p6y1qdq2avx5mjm6zai1n9xd-nixos-test-driver-dm-wireguard-star.drv' nixos-test-driver-dm-wireguard-star> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-dm-wireguard-star> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-dm-wireguard-star> All checks passed! nixos-test-driver-dm-wireguard-star> Linting test script (enable/disable: config.skipLint) nixos-test-driver-dm-wireguard-star> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-dm-wireguard-star> All checks passed! building '/nix/store/i6820xkbbdn2z7sdfb2sjla3nrc3wn3b-container-test-run-dm-wireguard-star.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/i6820xkbbdn2z7sdfb2sjla3nrc3wn3b-container-test-run-dm-wireguard-star.drv' container-test-run-dm-wireguard-star> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-dm-wireguard-star> start all VLans container-test-run-dm-wireguard-star> (finished: start all VLans, in 0.00 seconds) container-test-run-dm-wireguard-star> container-test-run-dm-wireguard-star> Test will time out and terminate in 3600.0 seconds container-test-run-dm-wireguard-star> run the VM test script container-test-run-dm-wireguard-star> additionally exposed symbols: container-test-run-dm-wireguard-star> controller, peer1, peer2, container-test-run-dm-wireguard-star> vlan1, container-test-run-dm-wireguard-star> 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-wireguard-star> controller: systemd-nspawn running (pid 50) container-test-run-dm-wireguard-star> controller: Waiting for journal at /build/vm-state-controller/var/log/journal... container-test-run-dm-wireguard-star> peer1: systemd-nspawn running (pid 53) container-test-run-dm-wireguard-star> peer1: Waiting for journal at /build/vm-state-peer1/var/log/journal... container-test-run-dm-wireguard-star> controller: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(peer1): 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-wireguard-star> nixos-nspawn(controller): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(controller): 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-wireguard-star> 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-wireguard-star> 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-wireguard-star> ░ Spawning container peer1 on /build/vm-state-peer1. container-test-run-dm-wireguard-star> ░ Spawning container controller on /build/vm-state-controller. container-test-run-dm-wireguard-star> controller # [7966944.322974] controller systemd-journald[105]: Journal started container-test-run-dm-wireguard-star> controller # [7966944.323012] controller systemd-journald[105]: Runtime Journal (/run/log/journal/f98d9706338445cea20128467640ecd6) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> controller # [7966944.323717] controller systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> controller # [7966944.328335] controller systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> controller # [7966944.328695] controller systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> controller # [7966944.328982] controller systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> controller # [7966944.332695] controller systemd-journald[105]: Time spent on flushing to /var/log/journal/f98d9706338445cea20128467640ecd6 is 983us for 6 entries. container-test-run-dm-wireguard-star> controller # [7966944.332695] controller systemd-journald[105]: System Journal (/var/log/journal/f98d9706338445cea20128467640ecd6) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> controller # [7966944.336692] controller systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> controller # [7966944.336806] controller systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> controller # [7966944.336850] controller systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> controller # [7966944.337253] controller systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> controller # [7966944.337280] controller systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [7966944.337719] controller systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> controller # [7966944.337735] controller systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> controller # [7966944.337913] controller systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [7966944.338625] controller systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> controller # [7966944.352495] controller systemd-tmpfiles[143]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.352649] controller systemd-tmpfiles[143]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.352750] controller systemd-tmpfiles[143]: fchmod() of /var/log/journal/f98d9706338445cea20128467640ecd6 failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.352901] controller systemd-tmpfiles[143]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.353949] controller systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> controller # [7966944.354217] controller systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> controller # [7966944.355592] controller systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> controller # [7966944.355939] controller systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> controller # [7966944.363208] controller systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> controller # [7966944.369225] controller systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> controller # [7966944.369942] controller systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> controller # [7966944.375365] controller systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> controller # [7966944.414926] controller systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> controller # [7966944.415059] controller systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> controller # [7966944.415234] controller systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> controller # [7966944.416007] controller systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> controller # [7966944.664042] controller systemd-networkd[225]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.664113] controller systemd-networkd[225]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.669599] controller systemd-networkd[225]: /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-wireguard-star> controller # [7966944.669744] controller systemd-networkd[225]: /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-wireguard-star> controller # [7966944.669796] controller systemd-networkd[225]: lo: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.322425] peer1 systemd-journald[96]: Journal started container-test-run-dm-wireguard-star> peer1 # [7966944.322450] peer1 systemd-journald[96]: Runtime Journal (/run/log/journal/b5879070c4174168ad3313e91b3c23d7) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> peer1 # [7966944.324736] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> peer1 # [7966944.329555] peer1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> peer1 # [7966944.329893] peer1 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> peer1 # [7966944.330164] peer1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> peer1 # [7966944.335532] peer1 systemd-journald[96]: Time spent on flushing to /var/log/journal/b5879070c4174168ad3313e91b3c23d7 is 1.092ms for 6 entries. container-test-run-dm-wireguard-star> peer1 # [7966944.335532] peer1 systemd-journald[96]: System Journal (/var/log/journal/b5879070c4174168ad3313e91b3c23d7) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> peer1 # [7966944.339663] peer1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> peer1 # [7966944.340086] peer1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> peer1 # [7966944.340144] peer1 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> peer1 # [7966944.340605] peer1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> peer1 # [7966944.340632] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer1 # [7966944.341054] peer1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> controller # [7966944.669798] controller systemd-networkd[225]: lo: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.341073] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> controller # [7966944.669914] controller systemd-networkd[225]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer1 # [7966944.341275] peer1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [7966944.670139] controller systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer1 # [7966944.342129] peer1 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer1 # [7966944.352475] peer1 systemd-tmpfiles[138]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.688136] controller systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer1 # [7966944.352665] peer1 systemd-tmpfiles[138]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.688452] controller systemd-networkd[225]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer1 # [7966944.352826] peer1 systemd-tmpfiles[138]: fchmod() of /var/log/journal/b5879070c4174168ad3313e91b3c23d7 failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.688634] controller systemd-networkd[225]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer1 # [7966944.352996] peer1 systemd-tmpfiles[138]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> controller # [7966944.690076] controller systemd-networkd[225]: eth1: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.354006] peer1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> controller # [7966944.690193] controller systemd-networkd[225]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.354221] peer1 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> controller # [7966944.709619] controller systemd-networkd[225]: wg-star: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.355327] peer1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> controller # [7966944.709623] controller systemd-networkd[225]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.355852] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> controller # [7966944.710388] controller systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer1 # [7966944.361515] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> controller # [7966944.793278] controller systemd-resolved[126]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer1 # [7966944.366992] peer1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> controller # [7966944.793286] controller systemd-resolved[126]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer1 # [7966944.367624] peer1 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> controller # [7966944.793289] controller systemd-resolved[126]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer1 # [7966944.373537] peer1 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> controller # [7966944.793305] controller systemd-resolved[126]: 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-wireguard-star> peer1 # [7966944.406982] peer1 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer1 # [7966944.407053] peer1 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer1 # [7966944.407208] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer1 # [7966944.407819] peer1 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer1 # [7966944.660883] peer1 systemd-networkd[214]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [7966944.660980] peer1 systemd-networkd[214]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [7966944.666713] peer1 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-wireguard-star> peer1 # [7966944.666878] peer1 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-wireguard-star> peer1 # [7966944.666967] peer1 systemd-networkd[214]: lo: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.666971] peer1 systemd-networkd[214]: lo: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.667138] peer1 systemd-networkd[214]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer1 # [7966944.667432] peer1 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer1 # [7966944.667827] peer1 systemd-networkd[214]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer1 # [7966944.668028] peer1 systemd-networkd[214]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer1 # [7966944.668093] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer1 # [7966944.668123] peer1 systemd-networkd[214]: eth1: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.668241] peer1 systemd-networkd[214]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.680277] peer1 systemd-networkd[214]: wg-star: Link UP container-test-run-dm-wireguard-star> peer1 # [7966944.680281] peer1 systemd-networkd[214]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer1 # [7966944.691715] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> controller # [7966944.803668] controller systemd-resolved[126]: Using system hostname 'controller'. container-test-run-dm-wireguard-star> controller # [7966944.804745] controller systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> controller # [7966944.804808] controller systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> controller # [7966944.804855] controller systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> controller # [7966944.804927] controller systemd[1]: Started Watch for WireGuard peer changes from data-mesher. container-test-run-dm-wireguard-star> controller # [7966944.804951] controller systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [7966944.804974] controller systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> controller # [7966944.804989] controller systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> controller # [7966944.805018] controller systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> controller # [7966944.805114] controller systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> controller # [7966944.805196] controller systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> controller # [7966944.805281] controller systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> controller # [7966944.805296] controller systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> controller # [7966944.805323] controller systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> controller # [7966944.806081] controller systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> controller # [7966944.806425] controller systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> controller # [7966944.806810] controller systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> controller # [7966944.807435] controller systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> controller # [7966944.838841] controller systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> controller # [7966944.894768] controller nsncd[232]: Aug 31 15:03:22.260 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> controller # [7966944.894846] controller systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> controller # [7966944.894887] controller systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> controller # [7966944.894943] controller systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> controller # [7966944.895497] controller systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> controller # [7966944.895795] controller systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer1 # [7966944.809453] peer1 systemd-resolved[119]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer1 # [7966944.809459] peer1 systemd-resolved[119]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer1 # [7966944.809462] peer1 systemd-resolved[119]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer1 # [7966944.809477] peer1 systemd-resolved[119]: 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-wireguard-star> peer1 # [7966944.819703] peer1 systemd-resolved[119]: Using system hostname 'peer1'. container-test-run-dm-wireguard-star> peer1 # [7966944.820743] peer1 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer1 # [7966944.820793] peer1 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer1 # [7966944.820831] peer1 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer1 # [7966944.820883] peer1 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer1 # [7966944.820901] peer1 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer1 # [7966944.820924] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer1 # [7966944.820936] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer1 # [7966944.820947] peer1 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer1 # [7966944.820965] peer1 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer1 # [7966944.821045] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer1 # [7966944.821107] peer1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer1 # [7966944.821174] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer1 # [7966944.821183] peer1 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer1 # [7966944.821201] peer1 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer1 # [7966944.830149] peer1 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer1 # [7966944.830579] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer1 # [7966944.830987] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer1 # [7966944.831586] peer1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer1 # [7966944.840549] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer1 # [7966944.900652] peer1 nsncd[221]: Aug 31 15:03:22.266 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> peer1 # [7966944.900704] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer1 # [7966944.900745] peer1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer1 # [7966944.900777] peer1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> peer1 # [7966944.917133] peer1 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer1 # [7966944.917536] peer1 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> controller # [7966944.920125] controller systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> controller # [7966944.920554] controller systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> controller # [7966944.920574] controller systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> controller # [7966944.920586] controller systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> controller # [7966944.944497] controller dbus-broker-launch[233]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> controller # [7966944.944913] controller dbus-broker-launch[233]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> controller # [7966944.944913] controller dbus-broker-launch[233]: Invalid user-name in /nix/store/37a9ydyl6jjxzyrg50w5rai4v2zhqhzk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> controller # [7966944.945291] controller systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> controller # [7966944.948859] controller dbus-broker-launch[233]: Ready container-test-run-dm-wireguard-star> controller # [7966945.101825] controller data-mesher[230]: time=2026-08-31T15:03:22.467Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> controller # [7966945.102971] controller data-mesher[230]: time=2026-08-31T15:03:22.468Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw: [/dns/controller.clan/tcp/7946]} {12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p: [/dns/peer1.clan/tcp/7946]} {12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> controller # [7966945.102997] controller data-mesher[230]: time=2026-08-31T15:03:22.468Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> controller # [7966945.103835] controller data-mesher[230]: time=2026-08-31T15:03:22.469Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> controller # [7966945.103905] controller data-mesher[230]: time=2026-08-31T15:03:22.469Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> controller # [7966945.105904] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="libp2p host created" peer_id=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw 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 /ip6/fda1:5c8::8bd9:edf:2cfc:8600/tcp/7946]" container-test-run-dm-wireguard-star> controller # [7966945.105923] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> controller # [7966945.105923] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> controller # [7966945.105947] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> controller # [7966945.105947] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> controller # [7966945.105997] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> controller # [7966945.106052] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> controller # [7966945.106092] controller data-mesher[230]: time=2026-08-31T15:03:22.471Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer1 # [7966944.922681] peer1 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer1 # [7966944.923211] peer1 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer1 # [7966944.923232] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer1 # [7966944.923242] peer1 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer1 # [7966944.947270] peer1 dbus-broker-launch[222]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer1 # [7966944.947590] peer1 dbus-broker-launch[222]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer1 # [7966944.947590] peer1 dbus-broker-launch[222]: Invalid user-name in /nix/store/37a9ydyl6jjxzyrg50w5rai4v2zhqhzk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer1 # [7966944.947832] peer1 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> peer1 # [7966944.950949] peer1 dbus-broker-launch[222]: Ready container-test-run-dm-wireguard-star> peer1 # [7966945.107735] peer1 data-mesher[219]: time=2026-08-31T15:03:22.473Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> peer1 # [7966945.108839] peer1 data-mesher[219]: time=2026-08-31T15:03:22.474Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw: [/dns/controller.clan/tcp/7946]} {12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p: [/dns/peer1.clan/tcp/7946]} {12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer1 # [7966945.108839] peer1 data-mesher[219]: time=2026-08-31T15:03:22.474Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer1 # [7966945.109401] peer1 data-mesher[219]: time=2026-08-31T15:03:22.475Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer1 # [7966945.109470] peer1 data-mesher[219]: time=2026-08-31T15:03:22.475Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer1 # [7966945.111231] peer1 data-mesher[219]: time=2026-08-31T15:03:22.476Z level=INFO msg="libp2p host created" peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p 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 /ip6/fda1:5c8::8a4b:5f21:e545:8091/tcp/7946]" container-test-run-dm-wireguard-star> peer1 # [7966945.111250] peer1 data-mesher[219]: time=2026-08-31T15:03:22.476Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer1 # [7966945.111250] peer1 data-mesher[219]: time=2026-08-31T15:03:22.476Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer1 # [7966945.111250] peer1 data-mesher[219]: time=2026-08-31T15:03:22.476Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer1 # [7966945.111289] peer1 data-mesher[219]: time=2026-08-31T15:03:22.476Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer1 # [7966945.111330] peer1 data-mesher[219]: time=2026-08-31T15:03:22.477Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer1 # [7966945.111366] peer1 data-mesher[219]: time=2026-08-31T15:03:22.477Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer1 # [7966945.111386] peer1 data-mesher[219]: time=2026-08-31T15:03:22.477Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> controller # [7966945.196664] controller systemd-logind[250]: New seat seat0. container-test-run-dm-wireguard-star> controller # [7966945.196769] controller systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> controller # [7966945.197369] controller systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> controller # [7966945.224735] controller systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [7966945.224826] controller systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> controller # [7966945.315922] controller systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966945.198281] peer1 systemd-logind[239]: New seat seat0. container-test-run-dm-wireguard-star> peer1 # [7966945.198358] peer1 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer1 # [7966945.220182] peer1 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer1 # [7966945.225781] peer1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966945.225817] peer1 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer1 # [7966945.315889] peer1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966946.237085] peer1 systemd-networkd[214]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> controller # [7966946.429084] controller systemd-networkd[225]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> controller # [7966950.114246] controller data-mesher[230]: time=2026-08-31T15:03:27.479Z level=INFO msg="peer connected" peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p remote_addr=/ip6/2001:db8:1::2/tcp/7946 container-test-run-dm-wireguard-star> controller # [7966950.114498] controller data-mesher[230]: time=2026-08-31T15:03:27.480Z level=INFO msg="peer connected" peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-dm-wireguard-star> controller # [7966950.114498] controller data-mesher[230]: time=2026-08-31T15:03:27.480Z level=INFO msg="peer disconnected" peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-dm-wireguard-star> peer1 # [7966950.114051] peer1 data-mesher[219]: time=2026-08-31T15:03:27.479Z level=INFO msg="peer connected" peer_id=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw remote_addr=/ip6/2001:db8:1::1/tcp/7946 container-test-run-dm-wireguard-star> controller: still waiting for container 'controller' to reach ready state... container-test-run-dm-wireguard-star> controller: (finished: waiting for unit data-mesher.service, in 11.64 seconds) container-test-run-dm-wireguard-star> peer1: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> peer1: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-dm-wireguard-star> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller, in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [7966955.106259] controller data-mesher[230]: time=2026-08-31T15:03:32.471Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> controller # [7966955.106259] controller data-mesher[230]: time=2026-08-31T15:03:32.471Z level=DEBUG msg="initiating state exchange" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966955.106735] controller data-mesher[230]: time=2026-08-31T15:03:32.472Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966955.106735] controller data-mesher[230]: time=2026-08-31T15:03:32.472Z level=INFO msg="state exchange complete" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966955.106766] controller data-mesher[230]: time=2026-08-31T15:03:32.472Z level=INFO msg="server started" container-test-run-dm-wireguard-star> controller # [7966955.106844] controller data-mesher[230]: time=2026-08-31T15:03:32.472Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> controller # [7966955.106933] controller systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> controller # [7966955.107653] controller systemd[1]: Starting Publish WireGuard controller info to data-mesher... container-test-run-dm-wireguard-star> controller # [7966955.112238] controller data-mesher[230]: time=2026-08-31T15:03:32.477Z level=INFO msg="received state sync from peer" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966955.112238] controller data-mesher[230]: time=2026-08-31T15:03:32.477Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966955.148031] controller data-mesher[230]: time=2026-08-31T15:03:32.513Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/controller status=204 container-test-run-dm-wireguard-star> controller # [7966955.148094] controller dm-wg-star-publish[283]: Status: 204 No Content container-test-run-dm-wireguard-star> controller # [7966955.148724] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [7966955.149689] controller systemd[1]: Finished Publish WireGuard controller info to data-mesher. container-test-run-dm-wireguard-star> controller # [7966955.149858] controller systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> controller # [7966955.189021] controller dm-wg-star-reconfig[299]: No peer data available yet, skipping container-test-run-dm-wireguard-star> controller # [7966955.189632] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [7966955.189709] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> controller # [7966955.191045] controller systemd[1]: Startup finished in 11.111s. container-test-run-dm-wireguard-star> peer1 # [7966955.106649] peer1 data-mesher[219]: time=2026-08-31T15:03:32.472Z level=INFO msg="received state sync from peer" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966955.106649] peer1 data-mesher[219]: time=2026-08-31T15:03:32.472Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966955.112080] peer1 data-mesher[219]: time=2026-08-31T15:03:32.477Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer1 # [7966955.112104] peer1 data-mesher[219]: time=2026-08-31T15:03:32.477Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966955.112294] peer1 data-mesher[219]: time=2026-08-31T15:03:32.477Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966955.112294] peer1 data-mesher[219]: time=2026-08-31T15:03:32.477Z level=INFO msg="state exchange complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966955.112333] peer1 data-mesher[219]: time=2026-08-31T15:03:32.477Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer1 # [7966955.112382] peer1 data-mesher[219]: time=2026-08-31T15:03:32.478Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer1 # [7966955.112435] peer1 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer1 # [7966955.132225] peer1 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer1 # [7966955.186829] peer1 data-mesher[219]: time=2026-08-31T15:03:32.552Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc status=204 container-test-run-dm-wireguard-star> peer1 # [7966955.186925] peer1 dm-wg-star-publish[274]: Status: 204 No Content container-test-run-dm-wireguard-star> peer1 # [7966955.187948] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [7966955.188775] peer1 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966955.188891] peer1 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer1 # [7966955.189162] peer1 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer1 # [7966955.232372] peer1 dm-wg-star-reconfig[289]: No controller data available yet, skipping container-test-run-dm-wireguard-star> peer1 # [7966955.233085] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966955.233150] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [7966955.233329] peer1 systemd[1]: Startup finished in 11.160s. container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller, in 5.02 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | grep -q . container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | grep -q ., in 0.00 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> controller: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.01 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8bd9:0edf:2cfc:8600 container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8bd9:0edf:2cfc:8600, in 0.00 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8a4b:5f21:e545:8091 container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8a4b:5f21:e545:8091, in 0.00 seconds) container-test-run-dm-wireguard-star> controller: must succeed: wg show wg-star peers | wc -l container-test-run-dm-wireguard-star> controller: (finished: must succeed: wg show wg-star peers | wc -l, in 0.01 seconds) container-test-run-dm-wireguard-star> peer2: systemd-nspawn running (pid 733) container-test-run-dm-wireguard-star> peer2: Waiting for journal at /build/vm-state-peer2/var/log/journal... container-test-run-dm-wireguard-star> peer2: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> controller # [7966960.110305] controller data-mesher[230]: time=2026-08-31T15:03:37.475Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [7966960.110305] controller data-mesher[230]: time=2026-08-31T15:03:37.475Z level=DEBUG msg="initiating state exchange" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966960.110989] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966960.111148] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=INFO msg="received file request" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [7966960.111148] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=DEBUG msg="new file detected" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> controller # [7966960.111148] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=INFO msg="state exchange complete" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966960.111220] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [7966960.111220] controller data-mesher[230]: time=2026-08-31T15:03:37.476Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> controller # [7966960.111409] controller data-mesher[230]: time=2026-08-31T15:03:37.477Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc signed_at="2026-08-31 15:03:32.55 +0000 UTC" signed_by="PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966960.111965] controller data-mesher[230]: time=2026-08-31T15:03:37.477Z level=INFO msg="file transfer complete" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [7966960.112597] controller data-mesher[230]: time=2026-08-31T15:03:37.478Z level=INFO msg="received state sync from peer" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966960.112597] controller data-mesher[230]: time=2026-08-31T15:03:37.478Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966960.112984] controller data-mesher[230]: time=2026-08-31T15:03:37.478Z level=DEBUG msg="new file detected" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> controller # [7966960.114524] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [7966960.115897] controller data-mesher[230]: time=2026-08-31T15:03:37.481Z level=INFO msg="download complete" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc signed_at="2026-08-31 15:03:32.55 +0000 UTC" signed_by="PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p written=true elapsed=4.514824ms container-test-run-dm-wireguard-star> controller # [7966960.186568] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [7966960.186676] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> nixos-nspawn(peer2): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(peer2): 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-wireguard-star> peer1 # [7966960.110803] peer1 data-mesher[219]: time=2026-08-31T15:03:37.476Z level=INFO msg="received state sync from peer" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966960.110803] peer1 data-mesher[219]: time=2026-08-31T15:03:37.476Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966960.110803] peer1 data-mesher[219]: time=2026-08-31T15:03:37.476Z level=DEBUG msg="new file detected" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [7966960.111205] peer1 data-mesher[219]: time=2026-08-31T15:03:37.476Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [7966960.111205] peer1 data-mesher[219]: time=2026-08-31T15:03:37.476Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-08-31 15:03:32.511 +0000 UTC" signed_by="fogB/MneQXC6Eeg1f1CAzhdfkHEgPTwGqa1uuQRshcM=" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966960.111640] peer1 data-mesher[219]: time=2026-08-31T15:03:37.477Z level=INFO msg="received file request" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer1 # [7966960.112352] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=INFO msg="file transfer complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer1 # [7966960.112416] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [7966960.112416] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966960.112783] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966960.112783] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=DEBUG msg="new file detected" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [7966960.112829] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=INFO msg="state exchange complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966960.112829] peer1 data-mesher[219]: time=2026-08-31T15:03:37.478Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [7966960.114008] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [7966960.115832] peer1 data-mesher[219]: time=2026-08-31T15:03:37.481Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-08-31 15:03:32.511 +0000 UTC" signed_by="fogB/MneQXC6Eeg1f1CAzhdfkHEgPTwGqa1uuQRshcM=" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw written=true elapsed=4.955503ms container-test-run-dm-wireguard-star> peer1 # [7966960.190475] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [7966960.190539] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> 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-wireguard-star> ░ Spawning container peer2 on /build/vm-state-peer2. container-test-run-dm-wireguard-star> peer2 # [7966961.015172] peer2 systemd-journald[96]: Journal started container-test-run-dm-wireguard-star> peer2 # [7966961.015200] peer2 systemd-journald[96]: Runtime Journal (/run/log/journal/801b676ee5b34eabbb22ca6e57eebd33) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> peer2 # [7966961.018741] peer2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> peer2 # [7966961.023146] peer2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> peer2 # [7966961.023463] peer2 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> peer2 # [7966961.023747] peer2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> peer2 # [7966961.027984] peer2 systemd-journald[96]: Time spent on flushing to /var/log/journal/801b676ee5b34eabbb22ca6e57eebd33 is 1.085ms for 6 entries. container-test-run-dm-wireguard-star> peer2 # [7966961.027984] peer2 systemd-journald[96]: System Journal (/var/log/journal/801b676ee5b34eabbb22ca6e57eebd33) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> peer2 # [7966961.031269] peer2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> peer2 # [7966961.031375] peer2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> peer2 # [7966961.031415] peer2 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> peer2 # [7966961.031797] peer2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> peer2 # [7966961.031820] peer2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [7966961.032196] peer2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> peer2 # [7966961.032215] peer2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer2 # [7966961.032413] peer2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> peer2 # [7966961.033120] peer2 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer2 # [7966961.042270] peer2 systemd-tmpfiles[137]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.042408] peer2 systemd-tmpfiles[137]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.042508] peer2 systemd-tmpfiles[137]: fchmod() of /var/log/journal/801b676ee5b34eabbb22ca6e57eebd33 failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.042652] peer2 systemd-tmpfiles[137]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.043554] peer2 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer2 # [7966961.044128] peer2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer2 # [7966961.044455] peer2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer2 # [7966961.051985] peer2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer2 # [7966961.060427] peer2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer2 # [7966961.060978] peer2 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer2 # [7966961.065830] peer2 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer2 # [7966961.068875] peer2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer2 # [7966961.098681] peer2 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer2 # [7966961.098761] peer2 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer2 # [7966961.098882] peer2 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer2 # [7966961.099290] peer2 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer2 # [7966961.350679] peer2 systemd-networkd[214]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.350759] peer2 systemd-networkd[214]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [7966961.356406] peer2 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-wireguard-star> peer2 # [7966961.356548] peer2 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-wireguard-star> peer2 # [7966961.356615] peer2 systemd-networkd[214]: lo: Link UP container-test-run-dm-wireguard-star> peer2 # [7966961.356619] peer2 systemd-networkd[214]: lo: Gained carrier container-test-run-dm-wireguard-star> peer2 # [7966961.356756] peer2 systemd-networkd[214]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer2 # [7966961.357006] peer2 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer2 # [7966961.357808] peer2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer2 # [7966961.358462] peer2 systemd-networkd[214]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer2 # [7966961.358658] peer2 systemd-networkd[214]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer2 # [7966961.358784] peer2 systemd-networkd[214]: eth1: Link UP container-test-run-dm-wireguard-star> peer2 # [7966961.358904] peer2 systemd-networkd[214]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer2 # [7966961.372291] peer2 systemd-networkd[214]: wg-star: Link UP container-test-run-dm-wireguard-star> peer2 # [7966961.372296] peer2 systemd-networkd[214]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer2 # [7966961.383852] peer2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer2 # [7966961.460077] peer2 systemd-resolved[121]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer2 # [7966961.460087] peer2 systemd-resolved[121]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer2 # [7966961.460092] peer2 systemd-resolved[121]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer2 # [7966961.460113] peer2 systemd-resolved[121]: 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-wireguard-star> peer2 # [7966961.474667] peer2 systemd-resolved[121]: Using system hostname 'peer2'. container-test-run-dm-wireguard-star> peer2 # [7966961.476196] peer2 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer2 # [7966961.476273] peer2 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer2 # [7966961.476315] peer2 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer2 # [7966961.476380] peer2 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer2 # [7966961.476404] peer2 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer2 # [7966961.476428] peer2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [7966961.476443] peer2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer2 # [7966961.476457] peer2 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer2 # [7966961.476483] peer2 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer2 # [7966961.476589] peer2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer2 # [7966961.476696] peer2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer2 # [7966961.476802] peer2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer2 # [7966961.476821] peer2 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer2 # [7966961.476859] peer2 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer2 # [7966961.477885] peer2 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer2 # [7966961.478532] peer2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer2 # [7966961.479111] peer2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer2 # [7966961.479840] peer2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer2 # [7966961.511583] peer2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer2 # [7966961.590962] peer2 nsncd[221]: Aug 31 15:03:38.956 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> peer2 # [7966961.591018] peer2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer2 # [7966961.591072] peer2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer2 # [7966961.591109] peer2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> peer2 # [7966961.591777] peer2 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer2 # [7966961.592118] peer2 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer2 # [7966961.622994] peer2 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer2 # [7966961.623566] peer2 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer2 # [7966961.623587] peer2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer2 # [7966961.623597] peer2 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer2 # [7966961.647646] peer2 dbus-broker-launch[222]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer2 # [7966961.648197] peer2 dbus-broker-launch[222]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer2 # [7966961.648197] peer2 dbus-broker-launch[222]: Invalid user-name in /nix/store/37a9ydyl6jjxzyrg50w5rai4v2zhqhzk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer2 # [7966961.648529] peer2 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> peer2 # [7966961.652143] peer2 dbus-broker-launch[222]: Ready container-test-run-dm-wireguard-star> peer2 # [7966961.808279] peer2 data-mesher[219]: time=2026-08-31T15:03:39.173Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> peer2 # [7966961.808586] peer2 data-mesher[219]: time=2026-08-31T15:03:39.174Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw: [/dns/controller.clan/tcp/7946]} {12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p: [/dns/peer1.clan/tcp/7946]} {12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> peer2 # [7966961.808605] peer2 data-mesher[219]: time=2026-08-31T15:03:39.174Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer2 # [7966961.809485] peer2 data-mesher[219]: time=2026-08-31T15:03:39.175Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer2 # [7966961.809565] peer2 data-mesher[219]: time=2026-08-31T15:03:39.175Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer2 # [7966961.812478] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="libp2p host created" peer_id=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.3/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::3/tcp/7946 /ip6/fda1:5c8::b361:35a4:4a35:4f8b/tcp/7946]" container-test-run-dm-wireguard-star> peer2 # [7966961.812501] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer2 # [7966961.812501] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer2 # [7966961.812501] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer2 # [7966961.812538] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer2 # [7966961.812572] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer2 # [7966961.812632] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer2 # [7966961.812704] peer2 data-mesher[219]: time=2026-08-31T15:03:39.178Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer2 # [7966961.814725] peer2 data-mesher[219]: time=2026-08-31T15:03:39.180Z level=INFO msg="peer connected" peer_id=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [7966961.816628] peer2 data-mesher[219]: time=2026-08-31T15:03:39.182Z level=INFO msg="peer connected" peer_id=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-dm-wireguard-star> controller # [7966961.814927] controller data-mesher[230]: time=2026-08-31T15:03:39.180Z level=INFO msg="peer connected" peer_id=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> peer1 # [7966961.816861] peer1 data-mesher[219]: time=2026-08-31T15:03:39.182Z level=INFO msg="peer connected" peer_id=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [7966961.940345] peer2 systemd-logind[239]: New seat seat0. container-test-run-dm-wireguard-star> peer2 # [7966961.940548] peer2 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer2 # [7966961.941647] peer2 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer2 # [7966961.973180] peer2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [7966961.973369] peer2 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer2 # [7966962.011455] peer2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [7966962.557668] peer2 systemd-networkd[214]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> peer2 # [7966965.114573] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="received state sync from peer" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer2 # [7966965.114573] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=DEBUG msg="new file detected" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=DEBUG msg="new file detected" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-08-31 15:03:32.511 +0000 UTC" signed_by="fogB/MneQXC6Eeg1f1CAzhdfkHEgPTwGqa1uuQRshcM=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer2 # [7966965.114834] peer2 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc signed_at="2026-08-31 15:03:32.55 +0000 UTC" signed_by="PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer2 # [7966965.117807] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [7966965.119457] peer2 data-mesher[219]: time=2026-08-31T15:03:42.485Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-08-31 15:03:32.511 +0000 UTC" signed_by="fogB/MneQXC6Eeg1f1CAzhdfkHEgPTwGqa1uuQRshcM=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p written=true elapsed=4.68256ms container-test-run-dm-wireguard-star> peer2 # [7966965.119792] peer2 data-mesher[219]: time=2026-08-31T15:03:42.485Z level=INFO msg="download complete" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc signed_at="2026-08-31 15:03:32.55 +0000 UTC" signed_by="PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc=" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p written=true elapsed=4.966915ms container-test-run-dm-wireguard-star> peer2 # [7966965.194369] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [7966965.194490] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> controller # [7966965.111585] controller data-mesher[230]: time=2026-08-31T15:03:42.477Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [7966965.111585] controller data-mesher[230]: time=2026-08-31T15:03:42.477Z level=DEBUG msg="initiating state exchange" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966965.112414] controller data-mesher[230]: time=2026-08-31T15:03:42.478Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966965.112518] controller data-mesher[230]: time=2026-08-31T15:03:42.478Z level=INFO msg="state exchange complete" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p timeout=5s container-test-run-dm-wireguard-star> controller # [7966965.112518] controller data-mesher[230]: time=2026-08-31T15:03:42.478Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [7966965.112014] peer1 data-mesher[219]: time=2026-08-31T15:03:42.477Z level=INFO msg="received state sync from peer" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966965.112014] peer1 data-mesher[219]: time=2026-08-31T15:03:42.477Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966965.113624] peer1 data-mesher[219]: time=2026-08-31T15:03:42.479Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [7966965.113624] peer1 data-mesher[219]: time=2026-08-31T15:03:42.479Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966965.114764] peer1 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="merging remote state" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> peer1 # [7966965.114764] peer1 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="state exchange complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966965.114827] peer1 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [7966965.114916] peer1 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="received file request" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [7966965.114989] peer1 data-mesher[219]: time=2026-08-31T15:03:42.480Z level=INFO msg="received file request" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer1 # [7966965.115555] peer1 data-mesher[219]: time=2026-08-31T15:03:42.481Z level=INFO msg="file transfer complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [7966965.116223] peer1 data-mesher[219]: time=2026-08-31T15:03:42.481Z level=INFO msg="file transfer complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/PwxNlUPWiotxOPHoJRE8sKChjFwqtCgcOfMhxq5fFoc container-test-run-dm-wireguard-star> peer2 # [7966970.113263] peer2 data-mesher[219]: time=2026-08-31T15:03:47.478Z level=INFO msg="received state sync from peer" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer2 # [7966970.113263] peer2 data-mesher[219]: time=2026-08-31T15:03:47.478Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer2 # [7966970.115342] peer2 data-mesher[219]: time=2026-08-31T15:03:47.481Z level=INFO msg="received state sync from peer" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> peer2 # [7966970.115342] peer2 data-mesher[219]: time=2026-08-31T15:03:47.481Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966970.113051] controller data-mesher[230]: time=2026-08-31T15:03:47.478Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [7966970.113051] controller data-mesher[230]: time=2026-08-31T15:03:47.478Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> controller # [7966970.113480] controller data-mesher[230]: time=2026-08-31T15:03:47.479Z level=INFO msg="merging remote state" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> controller # [7966970.113593] controller data-mesher[230]: time=2026-08-31T15:03:47.479Z level=INFO msg="state exchange complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> controller # [7966970.113615] controller data-mesher[230]: time=2026-08-31T15:03:47.479Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [7966970.115147] peer1 data-mesher[219]: time=2026-08-31T15:03:47.480Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [7966970.115147] peer1 data-mesher[219]: time=2026-08-31T15:03:47.480Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966970.115538] peer1 data-mesher[219]: time=2026-08-31T15:03:47.481Z level=INFO msg="merging remote state" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> peer1 # [7966970.115602] peer1 data-mesher[219]: time=2026-08-31T15:03:47.481Z level=INFO msg="state exchange complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966970.115617] peer1 data-mesher[219]: time=2026-08-31T15:03:47.481Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer2: still waiting for container 'peer2' to reach ready state... container-test-run-dm-wireguard-star> peer2: (finished: waiting for unit data-mesher.service, in 11.64 seconds) container-test-run-dm-wireguard-star> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: waiting for success: test $(ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | wc -l) -gt 1 container-test-run-dm-wireguard-star> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wsnxjqf86imlxfmxxxf02lp1kvcib7xs-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> peer2 # [7966971.813363] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer2 # [7966971.813363] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer2 # [7966971.813638] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer2 # [7966971.813745] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=INFO msg="state exchange complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer2 # [7966971.813745] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer2 # [7966971.813816] peer2 data-mesher[219]: time=2026-08-31T15:03:49.179Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer2 # [7966971.813880] peer2 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer2 # [7966971.814628] peer2 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer2 # [7966971.893398] peer2 data-mesher[219]: time=2026-08-31T15:03:49.259Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c status=204 container-test-run-dm-wireguard-star> peer2 # [7966971.893515] peer2 dm-wg-star-publish[285]: Status: 204 No Content container-test-run-dm-wireguard-star> peer2 # [7966971.894529] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [7966971.894721] peer2 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [7966971.894818] peer2 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer2 # [7966971.895490] peer2 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer2 # [7966971.967539] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [7966971.967635] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2 # [7966971.967796] peer2 systemd[1]: Startup finished in 11.185s. container-test-run-dm-wireguard-star> controller # [7966971.813524] controller data-mesher[230]: time=2026-08-31T15:03:49.179Z level=INFO msg="received state sync from peer" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> controller # [7966971.813524] controller data-mesher[230]: time=2026-08-31T15:03:49.179Z level=INFO msg="merging remote state" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test $(ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | wc -l) -gt 1, in 3.03 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: test $(wg show wg-star peers | wc -l) -gt 1 container-test-run-dm-wireguard-star> peer2 # [7966975.114320] peer2 data-mesher[219]: time=2026-08-31T15:03:52.479Z level=INFO msg="received state sync from peer" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer2 # [7966975.114320] peer2 data-mesher[219]: time=2026-08-31T15:03:52.480Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer2 # [7966975.114752] peer2 data-mesher[219]: time=2026-08-31T15:03:52.480Z level=INFO msg="received file request" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c container-test-run-dm-wireguard-star> peer2 # [7966975.115906] peer2 data-mesher[219]: time=2026-08-31T15:03:52.481Z level=INFO msg="file transfer complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw network="Ltj8cb5hNbt6pZ/rrUuUbGwi6MLKc8IOMu1dVj1JTew=" name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c container-test-run-dm-wireguard-star> peer1 # [7966975.116251] peer1 data-mesher[219]: time=2026-08-31T15:03:52.481Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [7966975.116251] peer1 data-mesher[219]: time=2026-08-31T15:03:52.481Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966975.116534] peer1 data-mesher[219]: time=2026-08-31T15:03:52.482Z level=INFO msg="merging remote state" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw container-test-run-dm-wireguard-star> peer1 # [7966975.116590] peer1 data-mesher[219]: time=2026-08-31T15:03:52.482Z level=INFO msg="state exchange complete" peer=12D3KooWGs8fHw8hC78ZobiMhk4Ev99uzfWVBFort3pzdmd9vMjw timeout=5s container-test-run-dm-wireguard-star> peer1 # [7966975.116609] peer1 data-mesher[219]: time=2026-08-31T15:03:52.482Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [7966975.114095] controller data-mesher[230]: time=2026-08-31T15:03:52.479Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [7966975.114095] controller data-mesher[230]: time=2026-08-31T15:03:52.479Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> controller # [7966975.114460] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=INFO msg="merging remote state" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> controller # [7966975.114513] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=DEBUG msg="new file detected" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c container-test-run-dm-wireguard-star> controller # [7966975.114571] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=INFO msg="state exchange complete" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW timeout=5s container-test-run-dm-wireguard-star> controller # [7966975.114595] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [7966975.114595] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c container-test-run-dm-wireguard-star> controller # [7966975.114627] controller data-mesher[230]: time=2026-08-31T15:03:52.480Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c signed_at="2026-08-31 15:03:49.257 +0000 UTC" signed_by="56gHy7fKkRQS++joJH6LI2jzrKUfOze6y7+KcdgUQ9c=" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW container-test-run-dm-wireguard-star> controller # [7966975.116408] controller data-mesher[230]: time=2026-08-31T15:03:52.482Z level=INFO msg="received state sync from peer" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966975.116408] controller data-mesher[230]: time=2026-08-31T15:03:52.482Z level=INFO msg="merging remote state" peer=12D3KooWE4UjZe3Ek8ZCzzrR8UrNDy2Xty5BnWUgLu7gH7EduK9p container-test-run-dm-wireguard-star> controller # [7966975.116819] controller data-mesher[230]: time=2026-08-31T15:03:52.482Z level=INFO msg="download complete" name=dm_wg_star_wg_star/56gHy7fKkRQS--joJH6LI2jzrKUfOze6y7-KcdgUQ9c signed_at="2026-08-31 15:03:49.257 +0000 UTC" signed_by="56gHy7fKkRQS++joJH6LI2jzrKUfOze6y7+KcdgUQ9c=" peer=12D3KooWRQexHS1cP36oiQEmRjTbhCLeKvZhLqXb1y6z1XNkkwrW written=true elapsed=2.200274ms container-test-run-dm-wireguard-star> controller # [7966975.117986] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [7966975.198698] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [7966975.205124] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test $(wg show wg-star peers | wc -l) -gt 1, in 1.01 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.00 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8bd9:0edf:2cfc:8600 container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8bd9:0edf:2cfc:8600, in 0.00 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::b361:35a4:4a35:4f8b container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::b361:35a4:4a35:4f8b, in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::b361:35a4:4a35:4f8b container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::b361:35a4:4a35:4f8b, in 0.00 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8a4b:5f21:e545:8091 container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::8a4b:5f21:e545:8091, in 0.00 seconds) container-test-run-dm-wireguard-star> (finished: run the VM test script, in 32.40 seconds) container-test-run-dm-wireguard-star> test script finished in 32.42s container-test-run-dm-wireguard-star> cleanup container-test-run-dm-wireguard-star> kill NspawnMachine (pid 50) container-test-run-dm-wireguard-star> kill NspawnMachine (pid 53) container-test-run-dm-wireguard-star> Container controller terminated by signal KILL. container-test-run-dm-wireguard-star> kill NspawnMachine (pid 733) container-test-run-dm-wireguard-star> Container peer1 terminated by signal KILL. container-test-run-dm-wireguard-star> Container peer2 terminated by signal KILL. container-test-run-dm-wireguard-star> (finished: cleanup, in 0.29 seconds) post-build step Upload to niks3: ok time=2026-08-31T15:03:54.158Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-08-31T15:03:54.600Z level=INFO msg="Uploading 1 narinfos" time=2026-08-31T15:03:55.067Z level=INFO msg="Upload complete. (989ms)"