don't know how to build these paths: /nix/store/b55bjs6yzd863z2y7aaxbjfqbaciyd66-container-test-run-dm-wireguard-star.drv warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/4xpp5hwdbrns2syrdc0h4bsav0lpd02g-system-path.drv' on nix-store.geninf.io:50051 system-path> gi-build-x86-02: building 4xpp5hwdbrns2syrdc0h4bsav0lpd02g-system-path.drv system-path> structuredAttrs is enabled system-path> created 1729 symlinks in user environment building '/nix/store/ndhidv783x80cclhf5yysb8sx6ambbrb-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> gi-build-x86-02: building ndhidv783x80cclhf5yysb8sx6ambbrb-dbus-1.drv building '/nix/store/yz68wa41f4lhd66cfhwad7kfzwh1szyv-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> gi-build-x86-02: building yz68wa41f4lhd66cfhwad7kfzwh1szyv-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/25w72xbabgdjvx00vagl3jb3fah75hh6-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> gi-build-x86-02: building 25w72xbabgdjvx00vagl3jb3fah75hh6-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/3hnhx58bvdaraisj796q15fxa01kbfm2-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> gi-build-x86-02: building 3hnhx58bvdaraisj796q15fxa01kbfm2-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/dxmcvwk1xvyzc4gk5g0rnix7g3sr8za2-user-units.drv' on nix-store.geninf.io:50051 user-units> gi-build-x86-02: building dxmcvwk1xvyzc4gk5g0rnix7g3sr8za2-user-units.drv building '/nix/store/pijpqkb2811858n93g7jsqm844qp9cd1-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building pijpqkb2811858n93g7jsqm844qp9cd1-system-units.drv building '/nix/store/8ajw55h8cca5xvwamf5s1dmvbjsbx007-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building 8ajw55h8cca5xvwamf5s1dmvbjsbx007-system-units.drv building '/nix/store/q4rm89fw1zqcfglid2cd62ka1asnv54m-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building q4rm89fw1zqcfglid2cd62ka1asnv54m-system-units.drv building '/nix/store/s1y57f0qnd7lnik7rajvg5zvpni3im85-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building s1y57f0qnd7lnik7rajvg5zvpni3im85-etc.drv building '/nix/store/m0slaf57z6gmy6ar6a2mrrx3qhi49bwm-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building m0slaf57z6gmy6ar6a2mrrx3qhi49bwm-etc.drv building '/nix/store/d8fwdq5dg1scrgvijx1k1x2ihp8rxw1m-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building d8fwdq5dg1scrgvijx1k1x2ihp8rxw1m-etc.drv building '/nix/store/bywr5h7y21843hkg7zppr0bb0gg9v0bb-activate.drv' on nix-store.geninf.io:50051 activate> gi-build-x86-02: building bywr5h7y21843hkg7zppr0bb0gg9v0bb-activate.drv activate> structuredAttrs is enabled building '/nix/store/d9bmwwim74mazml0ls7m88c80a6mv529-activate.drv' on nix-store.geninf.io:50051 activate> gi-build-x86-02: building d9bmwwim74mazml0ls7m88c80a6mv529-activate.drv activate> structuredAttrs is enabled building '/nix/store/zk26amwsjasm9kca6j8ai613za0wbqkh-nixos-system-peer2-test.drv' on nix-store.geninf.io:50051 nixos-system-peer2-test> gi-build-x86-02: building zk26amwsjasm9kca6j8ai613za0wbqkh-nixos-system-peer2-test.drv nixos-system-peer2-test> structuredAttrs is enabled building '/nix/store/v34p23av7swf9kcz445wgbd5pb86xz9s-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building v34p23av7swf9kcz445wgbd5pb86xz9s-activate.drv activate> structuredAttrs is enabled building '/nix/store/pxryq026qz77x53xssw6r58wxlhf21b6-nixos-system-peer1-test.drv' on nix-store.geninf.io:50051 nixos-system-peer1-test> gi-build-x86-02: building pxryq026qz77x53xssw6r58wxlhf21b6-nixos-system-peer1-test.drv nixos-system-peer1-test> structuredAttrs is enabled building '/nix/store/3lbqxyfhh7bj4mb27bk1lb7k1c344l58-run-peer2-nspawn.drv' on nix-store.geninf.io:50051 run-peer2-nspawn> gi-build-x86-02: building 3lbqxyfhh7bj4mb27bk1lb7k1c344l58-run-peer2-nspawn.drv building '/nix/store/v0ymig2dlyjg0ssvcpgm7dspjfxhrx1i-nixos-system-controller-test.drv' on nix-store.geninf.io:50051 nixos-system-controller-test> build-x86-01: building v0ymig2dlyjg0ssvcpgm7dspjfxhrx1i-nixos-system-controller-test.drv nixos-system-controller-test> structuredAttrs is enabled building '/nix/store/mz5yjl7hsbp3y93lisc15c3pnqhk99xz-run-peer1-nspawn.drv' on nix-store.geninf.io:50051 run-peer1-nspawn> gi-build-x86-02: building mz5yjl7hsbp3y93lisc15c3pnqhk99xz-run-peer1-nspawn.drv building '/nix/store/4g8438vbi5i5fr46clk0f5khhbacs8bp-run-controller-nspawn.drv' on nix-store.geninf.io:50051 run-controller-nspawn> build-x86-01: building 4g8438vbi5i5fr46clk0f5khhbacs8bp-run-controller-nspawn.drv building '/nix/store/cwb4p6qwa8ri05d3jj26gv11sml2sn2x-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> gi-build-x86-02: building cwb4p6qwa8ri05d3jj26gv11sml2sn2x-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/9dp6fk8jdgjw40irknb6mvsgcbx1j23y-nixos-test-driver-dm-wireguard-star.drv' on nix-store.geninf.io:50051 nixos-test-driver-dm-wireguard-star> gi-build-x86-02: building 9dp6fk8jdgjw40irknb6mvsgcbx1j23y-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/b55bjs6yzd863z2y7aaxbjfqbaciyd66-container-test-run-dm-wireguard-star.drv' on nix-store.geninf.io:50051 container-test-run-dm-wireguard-star> build-x86-01: building b55bjs6yzd863z2y7aaxbjfqbaciyd66-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 # [2479592.599561] controller systemd-journald[108]: Journal started container-test-run-dm-wireguard-star> controller # [2479592.599593] controller systemd-journald[108]: Runtime Journal (/run/log/journal/ad24efe8ff664eb28b30014af21b6b66) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> controller # [2479592.603653] controller systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> controller # [2479592.610028] controller systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> controller # [2479592.617280] controller systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> controller # [2479592.617638] controller systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> controller # [2479592.617923] controller systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> controller # [2479592.621730] controller systemd-journald[108]: Time spent on flushing to /var/log/journal/ad24efe8ff664eb28b30014af21b6b66 is 1.186ms for 7 entries. container-test-run-dm-wireguard-star> controller # [2479592.621730] controller systemd-journald[108]: System Journal (/var/log/journal/ad24efe8ff664eb28b30014af21b6b66) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> controller # [2479592.634752] controller systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [2479592.634951] controller systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> controller # [2479592.635648] controller systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> controller # [2479592.635695] controller systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> controller # [2479592.636143] controller systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> controller # [2479592.636171] controller systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [2479592.636595] controller systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> controller # [2479592.636895] controller systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> controller # [2479592.636907] controller systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> controller # [2479592.649430] controller systemd-tmpfiles[168]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [2479592.650462] controller systemd-tmpfiles[168]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.599089] peer1 systemd-journald[99]: Journal started container-test-run-dm-wireguard-star> controller # [2479592.651088] controller systemd-tmpfiles[168]: fchmod() of /var/log/journal/ad24efe8ff664eb28b30014af21b6b66 failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.599119] peer1 systemd-journald[99]: Runtime Journal (/run/log/journal/b25645abc4f54ffbbf79a85497db8570) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> controller # [2479592.651259] controller systemd-tmpfiles[168]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.603672] peer1 systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> controller # [2479592.652233] controller systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer1 # [2479592.610020] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> controller # [2479592.652780] controller systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer1 # [2479592.617364] peer1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> controller # [2479592.653068] controller systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer1 # [2479592.617690] peer1 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> controller # [2479592.659423] controller systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer1 # [2479592.617969] peer1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> controller # [2479592.660496] controller systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer1 # [2479592.623620] peer1 systemd-journald[99]: Time spent on flushing to /var/log/journal/b25645abc4f54ffbbf79a85497db8570 is 914us for 7 entries. container-test-run-dm-wireguard-star> controller # [2479592.665674] controller systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer1 # [2479592.623620] peer1 systemd-journald[99]: System Journal (/var/log/journal/b25645abc4f54ffbbf79a85497db8570) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> controller # [2479592.666163] controller systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer1 # [2479592.634746] peer1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [2479592.670807] controller systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer1 # [2479592.634928] peer1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> controller # [2479592.691042] controller systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer1 # [2479592.635799] peer1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> peer1 # [2479592.635854] peer1 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> controller # [2479592.691131] controller systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> controller # [2479592.691296] controller systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer1 # [2479592.636308] peer1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> controller # [2479592.691866] controller systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer1 # [2479592.636335] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer1 # [2479592.636720] peer1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> peer1 # [2479592.637074] peer1 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer1 # [2479592.637088] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer1 # [2479592.648596] peer1 systemd-tmpfiles[159]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.648827] peer1 systemd-tmpfiles[159]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.648922] peer1 systemd-tmpfiles[159]: fchmod() of /var/log/journal/b25645abc4f54ffbbf79a85497db8570 failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.649068] peer1 systemd-tmpfiles[159]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479592.650074] peer1 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer1 # [2479592.650660] peer1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer1 # [2479592.650978] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer1 # [2479592.657893] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer1 # [2479592.660044] peer1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer1 # [2479592.662774] peer1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer1 # [2479592.663344] peer1 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer1 # [2479592.668985] peer1 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer1 # [2479592.691057] peer1 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer1 # [2479592.691121] peer1 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer1 # [2479592.691269] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer1 # [2479592.691829] peer1 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> controller # [2479593.137803] controller systemd-networkd[228]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [2479593.137877] controller systemd-networkd[228]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [2479593.145385] controller systemd-networkd[228]: /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 # [2479593.145523] controller systemd-networkd[228]: /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 # [2479593.145594] controller systemd-networkd[228]: lo: Link UP container-test-run-dm-wireguard-star> controller # [2479593.145597] controller systemd-networkd[228]: lo: Gained carrier container-test-run-dm-wireguard-star> controller # [2479593.145723] controller systemd-networkd[228]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> controller # [2479593.145949] controller systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> controller # [2479593.146355] controller systemd-networkd[228]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> controller # [2479593.146507] controller systemd-networkd[228]: wg-star: netdev ready container-test-run-dm-wireguard-star> controller # [2479593.146564] controller systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> controller # [2479593.146599] controller systemd-networkd[228]: eth1: Link UP container-test-run-dm-wireguard-star> controller # [2479593.146698] controller systemd-networkd[228]: eth1: Gained carrier container-test-run-dm-wireguard-star> controller # [2479593.167347] controller systemd-networkd[228]: wg-star: Link UP container-test-run-dm-wireguard-star> controller # [2479593.167352] controller systemd-networkd[228]: wg-star: Gained carrier container-test-run-dm-wireguard-star> controller # [2479593.172182] controller systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer1 # [2479593.139365] peer1 systemd-networkd[217]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479593.139433] peer1 systemd-networkd[217]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [2479593.147195] peer1 systemd-networkd[217]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer1 # [2479593.147336] peer1 systemd-networkd[217]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer1 # [2479593.147391] peer1 systemd-networkd[217]: lo: Link UP container-test-run-dm-wireguard-star> peer1 # [2479593.147393] peer1 systemd-networkd[217]: lo: Gained carrier container-test-run-dm-wireguard-star> peer1 # [2479593.147506] peer1 systemd-networkd[217]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer1 # [2479593.147700] peer1 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer1 # [2479593.147982] peer1 systemd-networkd[217]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer1 # [2479593.148145] peer1 systemd-networkd[217]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer1 # [2479593.148231] peer1 systemd-networkd[217]: eth1: Link UP container-test-run-dm-wireguard-star> peer1 # [2479593.148282] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer1 # [2479593.148334] peer1 systemd-networkd[217]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer1 # [2479593.167420] peer1 systemd-networkd[217]: wg-star: Link UP container-test-run-dm-wireguard-star> peer1 # [2479593.167426] peer1 systemd-networkd[217]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer1 # [2479593.172812] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer1 # [2479593.467549] peer1 systemd-resolved[134]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer1 # [2479593.467554] peer1 systemd-resolved[134]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer1 # [2479593.467557] peer1 systemd-resolved[134]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer1 # [2479593.467572] peer1 systemd-resolved[134]: 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 # [2479593.477173] peer1 systemd-resolved[134]: Using system hostname 'peer1'. container-test-run-dm-wireguard-star> peer1 # [2479593.478076] peer1 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer1 # [2479593.478130] peer1 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer1 # [2479593.478171] peer1 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer1 # [2479593.478232] peer1 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer1 # [2479593.478253] peer1 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer1 # [2479593.478269] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer1 # [2479593.478284] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer1 # [2479593.478299] peer1 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer1 # [2479593.478325] peer1 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer1 # [2479593.478409] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer1 # [2479593.478481] peer1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer1 # [2479593.478560] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer1 # [2479593.478575] peer1 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer1 # [2479593.478603] peer1 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer1 # [2479593.499243] peer1 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer1 # [2479593.499662] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer1 # [2479593.500008] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer1 # [2479593.500531] peer1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer1 # [2479593.508561] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer1 # [2479593.596297] peer1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479593.615709] peer1 nsncd[224]: Oct 03 00:03:28.039 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 # [2479593.615751] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer1 # [2479593.615787] peer1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer1 # [2479593.615818] peer1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> peer1 # [2479593.626673] peer1 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer1 # [2479593.627133] peer1 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer1 # [2479593.632730] peer1 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer1 # [2479593.633137] peer1 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer1 # [2479593.633155] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer1 # [2479593.633166] peer1 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer1 # [2479593.717273] peer1 dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer1 # [2479593.717738] peer1 dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer1 # [2479593.717738] peer1 dbus-broker-launch[225]: Invalid user-name in /nix/store/9f7zk13j53kxsl41xzfkfgfq2wql5yxi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer1 # [2479593.717972] peer1 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> controller # [2479593.463077] controller systemd-resolved[142]: Positive Trust Anchors: container-test-run-dm-wireguard-star> controller # [2479593.463083] controller systemd-resolved[142]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> controller # [2479593.463086] controller systemd-resolved[142]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> controller # [2479593.463102] controller systemd-resolved[142]: 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> controller # [2479593.473301] controller systemd-resolved[142]: Using system hostname 'controller'. container-test-run-dm-wireguard-star> controller # [2479593.474325] controller systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> controller # [2479593.474379] controller systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> controller # [2479593.474420] controller systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> controller # [2479593.474493] controller systemd[1]: Started Watch for WireGuard peer changes from data-mesher. container-test-run-dm-wireguard-star> controller # [2479593.474514] controller systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [2479593.474538] controller systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> controller # [2479593.474552] controller systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> controller # [2479593.474578] controller systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> controller # [2479593.474670] controller systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> controller # [2479593.474741] controller systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> controller # [2479593.474809] controller systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> controller # [2479593.474818] controller systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> controller # [2479593.474836] controller systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> controller # [2479593.475573] controller systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> controller # [2479593.475935] controller systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> controller # [2479593.476329] controller systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> controller # [2479593.476921] controller systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> controller # [2479593.506819] controller systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> controller # [2479593.595953] controller systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [2479593.612230] controller nsncd[235]: Oct 03 00:03:28.035 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 # [2479593.612271] controller systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> controller # [2479593.612313] controller systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> controller # [2479593.612346] controller systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> controller # [2479593.613163] controller systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> controller # [2479593.613525] controller systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> controller # [2479593.630681] controller systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> controller # [2479593.631243] controller systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> controller # [2479593.631262] controller systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> controller # [2479593.631271] controller systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> controller # [2479593.725556] controller dbus-broker-launch[236]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> controller # [2479593.725901] controller dbus-broker-launch[236]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> controller # [2479593.725901] controller dbus-broker-launch[236]: Invalid user-name in /nix/store/9f7zk13j53kxsl41xzfkfgfq2wql5yxi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> controller # [2479593.726212] controller systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> controller # [2479593.729456] controller dbus-broker-launch[236]: Ready container-test-run-dm-wireguard-star> peer1 # [2479593.721393] peer1 dbus-broker-launch[225]: Ready container-test-run-dm-wireguard-star> controller # [2479594.013154] controller data-mesher[233]: time=2026-10-03T00:03:28.436Z 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 # [2479594.014607] controller data-mesher[233]: time=2026-10-03T00:03:28.437Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc: [/dns/controller.clan/tcp/7946]} {12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK: [/dns/peer1.clan/tcp/7946]} {12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> controller # [2479594.014607] controller data-mesher[233]: time=2026-10-03T00:03:28.437Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> controller # [2479594.015347] controller data-mesher[233]: time=2026-10-03T00:03:28.438Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> controller # [2479594.015418] controller data-mesher[233]: time=2026-10-03T00:03:28.438Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> controller # [2479594.017511] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="libp2p host created" peer_id=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc 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::375:3ab0:8930:c2db/tcp/7946]" container-test-run-dm-wireguard-star> controller # [2479594.017547] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> controller # [2479594.017547] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> controller # [2479594.017547] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> controller # [2479594.017580] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> controller # [2479594.017624] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> controller # [2479594.017679] controller data-mesher[233]: time=2026-10-03T00:03:28.440Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> controller # [2479594.017722] controller data-mesher[233]: time=2026-10-03T00:03:28.441Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> controller # [2479594.159138] controller systemd-logind[253]: New seat seat0. container-test-run-dm-wireguard-star> controller # [2479594.159268] controller systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> controller # [2479594.160291] controller systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> controller # [2479594.186599] controller systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [2479594.186650] controller systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer1 # [2479594.019151] peer1 data-mesher[222]: time=2026-10-03T00:03:28.442Z 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 # [2479594.019414] peer1 data-mesher[222]: time=2026-10-03T00:03:28.442Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc: [/dns/controller.clan/tcp/7946]} {12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK: [/dns/peer1.clan/tcp/7946]} {12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer1 # [2479594.019438] peer1 data-mesher[222]: time=2026-10-03T00:03:28.442Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer1 # [2479594.019992] peer1 data-mesher[222]: time=2026-10-03T00:03:28.443Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer1 # [2479594.020089] peer1 data-mesher[222]: time=2026-10-03T00:03:28.443Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer1 # [2479594.023138] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="libp2p host created" peer_id=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK 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::c36d:c4c9:f95c:eff8/tcp/7946]" container-test-run-dm-wireguard-star> peer1 # [2479594.023162] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer1 # [2479594.023162] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer1 # [2479594.023162] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer1 # [2479594.023162] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer1 # [2479594.023261] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer1 # [2479594.023261] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer1 # [2479594.023301] peer1 data-mesher[222]: time=2026-10-03T00:03:28.446Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer1 # [2479594.160754] peer1 systemd-logind[242]: New seat seat0. container-test-run-dm-wireguard-star> peer1 # [2479594.160861] peer1 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer1 # [2479594.161644] peer1 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer1 # [2479594.185787] peer1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479594.185858] peer1 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> controller # [2479594.305189] controller systemd-networkd[228]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> peer1 # [2479594.496129] peer1 systemd-networkd[217]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> peer1 # [2479599.021308] peer1 data-mesher[222]: time=2026-10-03T00:03:33.444Z level=INFO msg="peer connected" peer_id=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc remote_addr=/ip6/2001:db8:1::1/tcp/7946 container-test-run-dm-wireguard-star> controller # [2479599.020825] controller data-mesher[233]: time=2026-10-03T00:03:33.444Z level=INFO msg="peer connected" peer_id=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK remote_addr=/ip6/2001:db8:1::2/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 12.14 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/g8gdxw5226n5cx2gy3ljqfhkb5w6qm8i-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/g8gdxw5226n5cx2gy3ljqfhkb5w6qm8i-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> peer1 # [2479604.020590] peer1 data-mesher[222]: time=2026-10-03T00:03:38.443Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479604.020590] peer1 data-mesher[222]: time=2026-10-03T00:03:38.443Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479604.023876] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer1 # [2479604.023927] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479604.024155] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479604.024155] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479604.024194] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer1 # [2479604.024225] peer1 data-mesher[222]: time=2026-10-03T00:03:38.447Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer1 # [2479604.024308] peer1 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer1 # [2479604.037217] peer1 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer1 # [2479604.090782] peer1 data-mesher[222]: time=2026-10-03T00:03:38.514Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA status=204 container-test-run-dm-wireguard-star> peer1 # [2479604.090837] peer1 dm-wg-star-publish[277]: Status: 204 No Content container-test-run-dm-wireguard-star> peer1 # [2479604.091907] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [2479604.092129] peer1 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479604.092214] peer1 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer1 # [2479604.092817] peer1 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer1 # [2479604.135925] peer1 dm-wg-star-reconfig[292]: No controller data available yet, skipping container-test-run-dm-wireguard-star> peer1 # [2479604.136579] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479604.136648] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [2479604.136867] peer1 systemd[1]: Startup finished in 11.779s. container-test-run-dm-wireguard-star> controller # [2479604.020202] controller data-mesher[233]: time=2026-10-03T00:03:38.443Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> controller # [2479604.020202] controller data-mesher[233]: time=2026-10-03T00:03:38.443Z level=DEBUG msg="initiating state exchange" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479604.020666] controller data-mesher[233]: time=2026-10-03T00:03:38.443Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479604.020666] controller data-mesher[233]: time=2026-10-03T00:03:38.444Z level=INFO msg="state exchange complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479604.020706] controller data-mesher[233]: time=2026-10-03T00:03:38.444Z level=INFO msg="server started" container-test-run-dm-wireguard-star> controller # [2479604.020768] controller data-mesher[233]: time=2026-10-03T00:03:38.444Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> controller # [2479604.020861] controller systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> controller # [2479604.021602] controller systemd[1]: Starting Publish WireGuard controller info to data-mesher... container-test-run-dm-wireguard-star> controller # [2479604.024058] controller data-mesher[233]: time=2026-10-03T00:03:38.447Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479604.024058] controller data-mesher[233]: time=2026-10-03T00:03:38.447Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479604.052250] controller data-mesher[233]: time=2026-10-03T00:03:38.475Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/controller status=204 container-test-run-dm-wireguard-star> controller # [2479604.052316] controller dm-wg-star-publish[285]: Status: 204 No Content container-test-run-dm-wireguard-star> controller # [2479604.053141] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [2479604.053926] controller systemd[1]: Finished Publish WireGuard controller info to data-mesher. container-test-run-dm-wireguard-star> controller # [2479604.054227] controller systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> controller # [2479604.095790] controller dm-wg-star-reconfig[301]: No peer data available yet, skipping container-test-run-dm-wireguard-star> controller # [2479604.096478] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [2479604.096572] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> controller # [2479604.099045] controller systemd[1]: Startup finished in 11.734s. 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.01 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::0375:3ab0:8930:c2db container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::0375:3ab0:8930:c2db, in 0.00 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::c36d:c4c9:f95c:eff8 container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::c36d:c4c9:f95c:eff8, 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.00 seconds) container-test-run-dm-wireguard-star> peer2: systemd-nspawn running (pid 737) 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> 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> 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> peer1 # [2479609.022014] peer1 data-mesher[222]: time=2026-10-03T00:03:43.445Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> controller # [2479609.021556] controller data-mesher[233]: time=2026-10-03T00:03:43.444Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [2479609.022014] peer1 data-mesher[222]: time=2026-10-03T00:03:43.445Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> controller # [2479609.021556] controller data-mesher[233]: time=2026-10-03T00:03:43.444Z level=DEBUG msg="initiating state exchange" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479609.022360] peer1 data-mesher[222]: time=2026-10-03T00:03:43.445Z level=DEBUG msg="new file detected" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479609.022307] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer1 # [2479609.022360] peer1 data-mesher[222]: time=2026-10-03T00:03:43.445Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479609.022419] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=INFO msg="received file request" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [2479609.022360] peer1 data-mesher[222]: time=2026-10-03T00:03:43.445Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-10-03 00:03:38.473 +0000 UTC" signed_by="KmX9zzP3TaSrMuIkZ9jDp1fzDbAoW+5Oj2fK6XZVi2c=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> controller # [2479609.022419] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=DEBUG msg="new file detected" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> peer1 # [2479609.022876] peer1 data-mesher[222]: time=2026-10-03T00:03:43.446Z level=INFO msg="received file request" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> controller # [2479609.022419] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=INFO msg="state exchange complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479609.023646] peer1 data-mesher[222]: time=2026-10-03T00:03:43.446Z level=INFO msg="file transfer complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> controller # [2479609.022499] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [2479609.024767] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [2479609.022499] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> peer1 # [2479609.025041] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> controller # [2479609.022656] controller data-mesher[233]: time=2026-10-03T00:03:43.445Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA signed_at="2026-10-03 00:03:38.512 +0000 UTC" signed_by="CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA=" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer1 # [2479609.024868] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> controller # [2479609.023233] controller data-mesher[233]: time=2026-10-03T00:03:43.446Z level=INFO msg="file transfer complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479609.024963] controller data-mesher[233]: time=2026-10-03T00:03:43.448Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479609.024963] controller data-mesher[233]: time=2026-10-03T00:03:43.448Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer1 # [2479609.025215] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> controller # [2479609.025049] controller data-mesher[233]: time=2026-10-03T00:03:43.448Z level=DEBUG msg="new file detected" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> peer1 # [2479609.025215] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=DEBUG msg="new file detected" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479609.025427] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> peer1 # [2479609.025215] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> controller # [2479609.025749] controller data-mesher[233]: time=2026-10-03T00:03:43.449Z level=INFO msg="download complete" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA signed_at="2026-10-03 00:03:38.512 +0000 UTC" signed_by="CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA=" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK written=true elapsed=3.113434ms container-test-run-dm-wireguard-star> peer1 # [2479609.025215] peer1 data-mesher[222]: time=2026-10-03T00:03:43.448Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479609.102285] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479609.025692] peer1 data-mesher[222]: time=2026-10-03T00:03:43.449Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-10-03 00:03:38.473 +0000 UTC" signed_by="KmX9zzP3TaSrMuIkZ9jDp1fzDbAoW+5Oj2fK6XZVi2c=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc written=true elapsed=3.505844ms container-test-run-dm-wireguard-star> controller # [2479609.102369] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> peer1 # [2479609.103352] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479609.103390] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2 # [2479609.762545] peer2 systemd-journald[99]: Journal started container-test-run-dm-wireguard-star> peer2 # [2479609.762587] peer2 systemd-journald[99]: Runtime Journal (/run/log/journal/b28eb4579e024669b799f2f7d4414c4e) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> peer2 # [2479609.766859] peer2 systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> peer2 # [2479609.773683] peer2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> peer2 # [2479609.782115] peer2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> peer2 # [2479609.782467] peer2 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> peer2 # [2479609.782764] peer2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> peer2 # [2479609.812887] peer2 systemd-journald[99]: Time spent on flushing to /var/log/journal/b28eb4579e024669b799f2f7d4414c4e is 1.102ms for 7 entries. container-test-run-dm-wireguard-star> peer2 # [2479609.812887] peer2 systemd-journald[99]: System Journal (/var/log/journal/b28eb4579e024669b799f2f7d4414c4e) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> peer2 # [2479609.820936] peer2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> peer2 # [2479609.821129] peer2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> peer2 # [2479609.821991] peer2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> peer2 # [2479609.822040] peer2 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> peer2 # [2479609.822453] peer2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> peer2 # [2479609.822480] peer2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [2479609.822898] peer2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> peer2 # [2479609.823242] peer2 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer2 # [2479609.823256] peer2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer2 # [2479609.832723] peer2 systemd-tmpfiles[180]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479609.832860] peer2 systemd-tmpfiles[180]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479609.832954] peer2 systemd-tmpfiles[180]: fchmod() of /var/log/journal/b28eb4579e024669b799f2f7d4414c4e failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479609.833099] peer2 systemd-tmpfiles[180]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479609.834071] peer2 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer2 # [2479609.834694] peer2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer2 # [2479609.835019] peer2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer2 # [2479609.841544] peer2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer2 # [2479609.846213] peer2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer2 # [2479609.846730] peer2 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer2 # [2479609.852626] peer2 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer2 # [2479609.852797] peer2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer2 # [2479609.853421] peer2 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer2 # [2479609.853925] peer2 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer2 # [2479609.854075] peer2 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer2 # [2479609.854591] peer2 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer2 # [2479610.291761] peer2 systemd-networkd[217]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479610.291832] peer2 systemd-networkd[217]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [2479610.300130] peer2 systemd-networkd[217]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer2 # [2479610.300269] peer2 systemd-networkd[217]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer2 # [2479610.300354] peer2 systemd-networkd[217]: lo: Link UP container-test-run-dm-wireguard-star> peer2 # [2479610.300357] peer2 systemd-networkd[217]: lo: Gained carrier container-test-run-dm-wireguard-star> peer2 # [2479610.300510] peer2 systemd-networkd[217]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer2 # [2479610.300784] peer2 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer2 # [2479610.301160] peer2 systemd-networkd[217]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer2 # [2479610.301328] peer2 systemd-networkd[217]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer2 # [2479610.301449] peer2 systemd-networkd[217]: eth1: Link UP container-test-run-dm-wireguard-star> peer2 # [2479610.301503] peer2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer2 # [2479610.301559] peer2 systemd-networkd[217]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer2 # [2479610.324466] peer2 systemd-networkd[217]: wg-star: Link UP container-test-run-dm-wireguard-star> peer2 # [2479610.324473] peer2 systemd-networkd[217]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer2 # [2479610.327901] peer2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer2 # [2479610.632948] peer2 systemd-resolved[133]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer2 # [2479610.632957] peer2 systemd-resolved[133]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer2 # [2479610.632960] peer2 systemd-resolved[133]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer2 # [2479610.632982] peer2 systemd-resolved[133]: 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 # [2479610.642761] peer2 systemd-resolved[133]: Using system hostname 'peer2'. container-test-run-dm-wireguard-star> peer2 # [2479610.643795] peer2 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer2 # [2479610.643848] peer2 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer2 # [2479610.643883] peer2 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer2 # [2479610.643933] peer2 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer2 # [2479610.643949] peer2 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer2 # [2479610.643962] peer2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [2479610.643975] peer2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer2 # [2479610.643985] peer2 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer2 # [2479610.644011] peer2 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer2 # [2479610.644091] peer2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer2 # [2479610.644152] peer2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer2 # [2479610.644216] peer2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer2 # [2479610.644226] peer2 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer2 # [2479610.644246] peer2 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer2 # [2479610.644949] peer2 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer2 # [2479610.645269] peer2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer2 # [2479610.645620] peer2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer2 # [2479610.646174] peer2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer2 # [2479610.672474] peer2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer2 # [2479610.760140] peer2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [2479610.761921] peer2 nsncd[224]: Oct 03 00:03:45.185 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 # [2479610.761911] peer2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer2 # [2479610.761942] peer2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer2 # [2479610.761970] peer2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> peer2 # [2479610.762488] peer2 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer2 # [2479610.762790] peer2 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer2 # [2479610.791868] peer2 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer2 # [2479610.792767] peer2 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer2 # [2479610.792788] peer2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer2 # [2479610.792799] peer2 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer2 # [2479610.856473] peer2 dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer2 # [2479610.857012] peer2 dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer2 # [2479610.857012] peer2 dbus-broker-launch[225]: Invalid user-name in /nix/store/9f7zk13j53kxsl41xzfkfgfq2wql5yxi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer2 # [2479610.857330] peer2 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> peer2 # [2479610.860921] peer2 dbus-broker-launch[225]: Ready container-test-run-dm-wireguard-star> peer2 # [2479611.146591] peer2 data-mesher[222]: time=2026-10-03T00:03:45.569Z 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 # [2479611.147829] peer2 data-mesher[222]: time=2026-10-03T00:03:45.571Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc: [/dns/controller.clan/tcp/7946]} {12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK: [/dns/peer1.clan/tcp/7946]} {12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer2 # [2479611.147855] peer2 data-mesher[222]: time=2026-10-03T00:03:45.571Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer2 # [2479611.149334] peer2 data-mesher[222]: time=2026-10-03T00:03:45.572Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer2 # [2479611.149406] peer2 data-mesher[222]: time=2026-10-03T00:03:45.572Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer2 # [2479611.151263] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="libp2p host created" peer_id=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j 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::9c98:dff:ff3b:7791/tcp/7946]" container-test-run-dm-wireguard-star> peer2 # [2479611.151282] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer2 # [2479611.151282] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer2 # [2479611.151306] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer2 # [2479611.151306] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer2 # [2479611.151356] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer2 # [2479611.151438] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer2 # [2479611.151438] peer2 data-mesher[222]: time=2026-10-03T00:03:45.574Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer2 # [2479611.153724] peer2 data-mesher[222]: time=2026-10-03T00:03:45.577Z level=INFO msg="peer connected" peer_id=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [2479611.155564] peer2 data-mesher[222]: time=2026-10-03T00:03:45.578Z level=INFO msg="peer connected" peer_id=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [2479611.302673] peer2 systemd-logind[242]: New seat seat0. container-test-run-dm-wireguard-star> peer2 # [2479611.302792] peer2 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer2 # [2479611.303634] peer2 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer2 # [2479611.322113] peer2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [2479611.322214] peer2 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer1 # [2479611.156058] peer1 data-mesher[222]: time=2026-10-03T00:03:45.579Z level=INFO msg="peer connected" peer_id=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> controller # [2479611.154104] controller data-mesher[233]: time=2026-10-03T00:03:45.577Z level=INFO msg="peer connected" peer_id=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [2479611.520131] peer2 systemd-networkd[217]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> peer1 # [2479614.023727] peer1 data-mesher[222]: time=2026-10-03T00:03:48.447Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479614.023727] peer1 data-mesher[222]: time=2026-10-03T00:03:48.447Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479614.025243] peer1 data-mesher[222]: time=2026-10-03T00:03:48.448Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [2479614.025243] peer1 data-mesher[222]: time=2026-10-03T00:03:48.448Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479614.025574] peer1 data-mesher[222]: time=2026-10-03T00:03:48.448Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479614.025624] peer1 data-mesher[222]: time=2026-10-03T00:03:48.448Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479614.025641] peer1 data-mesher[222]: time=2026-10-03T00:03:48.448Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479614.023431] controller data-mesher[233]: time=2026-10-03T00:03:48.446Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [2479614.023649] controller data-mesher[233]: time=2026-10-03T00:03:48.446Z level=DEBUG msg="initiating state exchange" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479614.023965] controller data-mesher[233]: time=2026-10-03T00:03:48.447Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479614.024065] controller data-mesher[233]: time=2026-10-03T00:03:48.447Z level=INFO msg="state exchange complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479614.024109] controller data-mesher[233]: time=2026-10-03T00:03:48.447Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479614.025427] controller data-mesher[233]: time=2026-10-03T00:03:48.448Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479614.025427] controller data-mesher[233]: time=2026-10-03T00:03:48.448Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer1 # [2479619.026535] peer1 data-mesher[222]: time=2026-10-03T00:03:53.449Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [2479619.026739] peer1 data-mesher[222]: time=2026-10-03T00:03:53.449Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479619.026947] peer1 data-mesher[222]: time=2026-10-03T00:03:53.450Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479619.027007] peer1 data-mesher[222]: time=2026-10-03T00:03:53.450Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479619.027023] peer1 data-mesher[222]: time=2026-10-03T00:03:53.450Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479619.024267] controller data-mesher[233]: time=2026-10-03T00:03:53.447Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [2479619.024464] controller data-mesher[233]: time=2026-10-03T00:03:53.447Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> controller # [2479619.024819] controller data-mesher[233]: time=2026-10-03T00:03:53.448Z level=INFO msg="merging remote state" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> controller # [2479619.024819] controller data-mesher[233]: time=2026-10-03T00:03:53.448Z level=INFO msg="state exchange complete" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> controller # [2479619.024858] controller data-mesher[233]: time=2026-10-03T00:03:53.448Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479619.025078] controller data-mesher[233]: time=2026-10-03T00:03:53.448Z level=INFO msg="received file request" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> controller # [2479619.025078] controller data-mesher[233]: time=2026-10-03T00:03:53.448Z level=INFO msg="received file request" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479619.026212] controller data-mesher[233]: time=2026-10-03T00:03:53.449Z level=INFO msg="file transfer complete" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> controller # [2479619.026463] controller data-mesher[233]: time=2026-10-03T00:03:53.449Z level=INFO msg="file transfer complete" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [2479619.026805] controller data-mesher[233]: time=2026-10-03T00:03:53.450Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479619.026805] controller data-mesher[233]: time=2026-10-03T00:03:53.450Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer2: still waiting for container 'peer2' to reach ready state... container-test-run-dm-wireguard-star> peer2 # [2479619.024609] peer2 data-mesher[222]: time=2026-10-03T00:03:53.447Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479619.024609] peer2 data-mesher[222]: time=2026-10-03T00:03:53.447Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=DEBUG msg="new file detected" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=DEBUG msg="new file detected" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA signed_at="2026-10-03 00:03:38.512 +0000 UTC" signed_by="CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479619.024900] peer2 data-mesher[222]: time=2026-10-03T00:03:53.448Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-10-03 00:03:38.473 +0000 UTC" signed_by="KmX9zzP3TaSrMuIkZ9jDp1fzDbAoW+5Oj2fK6XZVi2c=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479619.027176] peer2 data-mesher[222]: time=2026-10-03T00:03:53.450Z level=INFO msg="download complete" name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA signed_at="2026-10-03 00:03:38.512 +0000 UTC" signed_by="CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc written=true elapsed=2.355596ms container-test-run-dm-wireguard-star> peer2 # [2479619.027549] peer2 data-mesher[222]: time=2026-10-03T00:03:53.450Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-10-03 00:03:38.473 +0000 UTC" signed_by="KmX9zzP3TaSrMuIkZ9jDp1fzDbAoW+5Oj2fK6XZVi2c=" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc written=true elapsed=2.727367ms container-test-run-dm-wireguard-star> peer2 # [2479619.027890] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [2479619.099236] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [2479619.099353] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2: (finished: waiting for unit data-mesher.service, in 12.14 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/g8gdxw5226n5cx2gy3ljqfhkb5w6qm8i-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/g8gdxw5226n5cx2gy3ljqfhkb5w6qm8i-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> peer2 # [2479621.151706] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer2 # [2479621.151706] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer2 # [2479621.152119] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479621.152208] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer2 # [2479621.152232] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer2 # [2479621.152268] peer2 data-mesher[222]: time=2026-10-03T00:03:55.575Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer2 # [2479621.152364] peer2 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer2 # [2479621.153108] peer2 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer2 # [2479621.230797] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [2479621.230846] peer2 data-mesher[222]: time=2026-10-03T00:03:55.654Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY status=204 container-test-run-dm-wireguard-star> peer2 # [2479621.230896] peer2 dm-wg-star-publish[287]: Status: 204 No Content container-test-run-dm-wireguard-star> peer2 # [2479621.233183] peer2 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [2479621.257076] peer2 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer2 # [2479621.257495] peer2 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer2 # [2479621.305247] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [2479621.305402] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2 # [2479621.305609] peer2 systemd[1]: Startup finished in 11.769s. container-test-run-dm-wireguard-star> controller # [2479621.151921] controller data-mesher[233]: time=2026-10-03T00:03:55.575Z level=INFO msg="received state sync from peer" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> controller # [2479621.151921] controller data-mesher[233]: time=2026-10-03T00:03:55.575Z level=INFO msg="merging remote state" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer1 # [2479624.025789] peer1 data-mesher[222]: time=2026-10-03T00:03:58.449Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479624.025789] peer1 data-mesher[222]: time=2026-10-03T00:03:58.449Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479624.027142] peer1 data-mesher[222]: time=2026-10-03T00:03:58.450Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [2479624.027167] peer1 data-mesher[222]: time=2026-10-03T00:03:58.450Z level=DEBUG msg="initiating state exchange" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479624.027382] peer1 data-mesher[222]: time=2026-10-03T00:03:58.450Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer1 # [2479624.027436] peer1 data-mesher[222]: time=2026-10-03T00:03:58.450Z level=INFO msg="state exchange complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479624.027458] peer1 data-mesher[222]: time=2026-10-03T00:03:58.450Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479624.025581] controller data-mesher[233]: time=2026-10-03T00:03:58.448Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [2479624.025581] controller data-mesher[233]: time=2026-10-03T00:03:58.448Z level=DEBUG msg="initiating state exchange" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479624.025948] controller data-mesher[233]: time=2026-10-03T00:03:58.449Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479624.026033] controller data-mesher[233]: time=2026-10-03T00:03:58.449Z level=INFO msg="state exchange complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> controller # [2479624.026066] controller data-mesher[233]: time=2026-10-03T00:03:58.449Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479624.027263] controller data-mesher[233]: time=2026-10-03T00:03:58.450Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> controller # [2479624.027263] controller data-mesher[233]: time=2026-10-03T00:03:58.450Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer2 # [2479626.152463] peer2 data-mesher[222]: time=2026-10-03T00:04:00.575Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-dm-wireguard-star> peer2 # [2479626.152463] peer2 data-mesher[222]: time=2026-10-03T00:04:00.575Z level=DEBUG msg="initiating state exchange" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> peer2 # [2479626.153052] peer2 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer2 # [2479626.153183] peer2 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="received file request" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer2 # [2479626.153183] peer2 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="state exchange complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK timeout=5s container-test-run-dm-wireguard-star> peer2 # [2479626.153252] peer2 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer2 # [2479626.154074] peer2 data-mesher[222]: time=2026-10-03T00:04:00.577Z level=INFO msg="file transfer complete" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer1 # [2479626.152731] peer1 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="received state sync from peer" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer1 # [2479626.152731] peer1 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="merging remote state" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer1 # [2479626.153069] peer1 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=DEBUG msg="new file detected" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer1 # [2479626.153069] peer1 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer1 # [2479626.153069] peer1 data-mesher[222]: time=2026-10-03T00:04:00.576Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY signed_at="2026-10-03 00:03:55.652 +0000 UTC" signed_by="q+6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY=" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer1 # [2479626.155981] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [2479626.156457] peer1 data-mesher[222]: time=2026-10-03T00:04:00.579Z level=INFO msg="download complete" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY signed_at="2026-10-03 00:03:55.652 +0000 UTC" signed_by="q+6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY=" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j written=true elapsed=3.478732ms container-test-run-dm-wireguard-star> peer1 # [2479626.223961] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [2479626.224121] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [2479629.028014] peer1 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [2479629.028014] peer1 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479629.028473] peer1 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="merging remote state" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> peer1 # [2479629.028561] peer1 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="state exchange complete" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> peer1 # [2479629.028582] peer1 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479629.026922] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [2479629.026922] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> controller # [2479629.027481] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=INFO msg="merging remote state" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> controller # [2479629.027568] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=DEBUG msg="new file detected" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j name=dm_wg_star_wg_star/CVKxFydc87xaCEOsUkbAsrmE68I5l8mqQFzeapEkKOA name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> controller # [2479629.027595] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=INFO msg="state exchange complete" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j timeout=5s container-test-run-dm-wireguard-star> controller # [2479629.027595] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [2479629.027649] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> controller # [2479629.027649] controller data-mesher[233]: time=2026-10-03T00:04:03.450Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY signed_at="2026-10-03 00:03:55.652 +0000 UTC" signed_by="q+6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY=" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j container-test-run-dm-wireguard-star> controller # [2479629.029207] controller data-mesher[233]: time=2026-10-03T00:04:03.452Z level=INFO msg="download complete" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY signed_at="2026-10-03 00:03:55.652 +0000 UTC" signed_by="q+6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY=" peer=12D3KooWMPWs9aKgHJhbes9uwANoEH35yZsQ4fw37Xg3qBnXPT3j written=true elapsed=1.56601ms container-test-run-dm-wireguard-star> controller # [2479629.029718] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [2479629.105708] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [2479629.105790] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> peer2 # [2479629.027223] peer2 data-mesher[222]: time=2026-10-03T00:04:03.450Z level=INFO msg="received state sync from peer" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479629.027223] peer2 data-mesher[222]: time=2026-10-03T00:04:03.450Z level=INFO msg="merging remote state" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc container-test-run-dm-wireguard-star> peer2 # [2479629.027796] peer2 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="received file request" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer2 # [2479629.028023] peer2 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="file transfer complete" peer=12D3KooWQBtx3u69HNUY42USobYSHfK83SZnpB37GBZtjkLXFfhc network="DTueDPD8Vynf7+UtkJ6sKBsVBu0/EcN0Z5Y5Tf1HIfM=" name=dm_wg_star_wg_star/q-6OYrWSyzCBgTA3if13Kp6r7w1q4E64GXXTmPPO4TY container-test-run-dm-wireguard-star> peer2 # [2479629.028268] peer2 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="received state sync from peer" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK container-test-run-dm-wireguard-star> peer2 # [2479629.028268] peer2 data-mesher[222]: time=2026-10-03T00:04:03.451Z level=INFO msg="merging remote state" peer=12D3KooWASkyH3DmocSayyYPsbCKdhNH9PSyAi42SM6VB8kVSuQK 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 8.05 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> controller: (finished: waiting for success: test $(wg show wg-star peers | wc -l) -gt 1, in 0.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.01 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::0375:3ab0:8930:c2db container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::0375:3ab0:8930:c2db, in 0.73 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::9c98:0dff:ff3b:7791 container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::9c98:0dff:ff3b:7791, in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::9c98:0dff:ff3b:7791 container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::9c98:0dff:ff3b:7791, in 0.00 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::c36d:c4c9:f95c:eff8 container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::c36d:c4c9:f95c:eff8, in 0.00 seconds) container-test-run-dm-wireguard-star> (finished: run the VM test script, in 38.15 seconds) container-test-run-dm-wireguard-star> test script finished in 38.19s 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> kill NspawnMachine (pid 737) container-test-run-dm-wireguard-star> Container controller terminated by signal KILL. container-test-run-dm-wireguard-star> Container peer1 terminated by signal KILL. container-test-run-dm-wireguard-star> (finished: cleanup, in 0.21 seconds) container-test-run-dm-wireguard-star> Container peer2 terminated by signal KILL.