don't know how to build these paths: /nix/store/92qpj8bd1iid3nxa5r2nwc6jwfssa7n2-container-test-run-data-mesher.drv warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user building '/nix/store/7ir0kz4xf5dl71gi36dzwv9yin3rmham-system-path.drv' on nix-store.geninf.io:50051 system-path> web01: building 7ir0kz4xf5dl71gi36dzwv9yin3rmham-system-path.drv system-path> structuredAttrs is enabled system-path> created 1721 symlinks in user environment building '/nix/store/3pnvlfxwjw592fpspli7k72lxp4iq4l5-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> build-x86-01: building 3pnvlfxwjw592fpspli7k72lxp4iq4l5-dbus-1.drv building '/nix/store/cg8s65h782bmzm3abbh199bzq686yk14-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> build-x86-01: building cg8s65h782bmzm3abbh199bzq686yk14-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/5lyd2mgnin8m23mvyhwichf9hh5f06jb-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building 5lyd2mgnin8m23mvyhwichf9hh5f06jb-unit-dbus-broker.service.drv building '/nix/store/62643ax75qdw06w6khsl7bdv1m574pdi-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building 62643ax75qdw06w6khsl7bdv1m574pdi-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/qg8f1yv1svwv4jd6xxmr8hg90nnzp4l9-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building qg8f1yv1svwv4jd6xxmr8hg90nnzp4l9-system-units.drv building '/nix/store/pd80hcrcmp3a00ybginfax013w8227js-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building pd80hcrcmp3a00ybginfax013w8227js-system-units.drv building '/nix/store/82v98cb7h98drghafxwzs3snvng25laq-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building 82v98cb7h98drghafxwzs3snvng25laq-system-units.drv building '/nix/store/yhdgkp9lq20mdjdzvilj6icnldb0swrc-user-units.drv' on nix-store.geninf.io:50051 user-units> build-x86-01: building yhdgkp9lq20mdjdzvilj6icnldb0swrc-user-units.drv building '/nix/store/pvkpzv0gnzymps1zwacbb00ps92yas7p-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building pvkpzv0gnzymps1zwacbb00ps92yas7p-etc.drv building '/nix/store/5p0z4rispqzvdzwc87wmkm1zlm7hsh3k-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building 5p0z4rispqzvdzwc87wmkm1zlm7hsh3k-etc.drv building '/nix/store/hi2ghgil1jkjv3gv9zqy9f6hh8kywxys-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building hi2ghgil1jkjv3gv9zqy9f6hh8kywxys-etc.drv building '/nix/store/1jhiv03l76z1ji6ivnhhshskyaaiv1j0-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building 1jhiv03l76z1ji6ivnhhshskyaaiv1j0-activate.drv activate> structuredAttrs is enabled building '/nix/store/i8gmkalpdhvbqcy6cy39y3i0cyzjv1a0-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building i8gmkalpdhvbqcy6cy39y3i0cyzjv1a0-activate.drv building '/nix/store/7nvid4gxf04z142pqjwf3mz6lqxv5r2i-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building 7nvid4gxf04z142pqjwf3mz6lqxv5r2i-activate.drv activate> structuredAttrs is enabled activate> structuredAttrs is enabled building '/nix/store/ypg03lg1mlr3k3h83bj4xc89k4mqjvs8-nixos-system-gamma-test.drv' on nix-store.geninf.io:50051 nixos-system-gamma-test> build-x86-01: building ypg03lg1mlr3k3h83bj4xc89k4mqjvs8-nixos-system-gamma-test.drv nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/b218n9a0frralnp7rw7zxzjn064azw0p-nixos-system-alpha-test.drv' on nix-store.geninf.io:50051 nixos-system-alpha-test> build-x86-01: building b218n9a0frralnp7rw7zxzjn064azw0p-nixos-system-alpha-test.drv nixos-system-alpha-test> structuredAttrs is enabled building '/nix/store/hra95j4bgc4vj1pgk3m50l9dcygsl49w-nixos-system-beta-test.drv' on nix-store.geninf.io:50051 nixos-system-beta-test> build-x86-01: building hra95j4bgc4vj1pgk3m50l9dcygsl49w-nixos-system-beta-test.drv nixos-system-beta-test> structuredAttrs is enabled building '/nix/store/iahzfl41xgw1ifjj34m2fnwmy4dspi9n-run-gamma-nspawn.drv' on nix-store.geninf.io:50051 run-gamma-nspawn> build-x86-01: building iahzfl41xgw1ifjj34m2fnwmy4dspi9n-run-gamma-nspawn.drv building '/nix/store/d5vby0jfi1im2hwfll0j5k16czjgj87n-run-alpha-nspawn.drv' on nix-store.geninf.io:50051 run-alpha-nspawn> build-x86-01: building d5vby0jfi1im2hwfll0j5k16czjgj87n-run-alpha-nspawn.drv building '/nix/store/279pszmwslsf6ll5chd8jvzxssd3lrzs-run-beta-nspawn.drv' on nix-store.geninf.io:50051 run-beta-nspawn> build-x86-01: building 279pszmwslsf6ll5chd8jvzxssd3lrzs-run-beta-nspawn.drv building '/nix/store/g8m064lj6w47k7xxh9zjwgv27vka25c3-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> build-x86-01: building g8m064lj6w47k7xxh9zjwgv27vka25c3-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/qny97wvc03g05l0i9iqsgkvmywgh3xh7-nixos-test-driver-data-mesher.drv' on nix-store.geninf.io:50051 nixos-test-driver-data-mesher> build-x86-01: building qny97wvc03g05l0i9iqsgkvmywgh3xh7-nixos-test-driver-data-mesher.drv nixos-test-driver-data-mesher> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-data-mesher> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-data-mesher> All checks passed! nixos-test-driver-data-mesher> Linting test script (enable/disable: config.skipLint) nixos-test-driver-data-mesher> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-data-mesher> All checks passed! building '/nix/store/92qpj8bd1iid3nxa5r2nwc6jwfssa7n2-container-test-run-data-mesher.drv' on nix-store.geninf.io:50051 container-test-run-data-mesher> build-x86-01: building 92qpj8bd1iid3nxa5r2nwc6jwfssa7n2-container-test-run-data-mesher.drv container-test-run-data-mesher> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-data-mesher> start all VLans container-test-run-data-mesher> (finished: start all VLans, in 0.00 seconds) container-test-run-data-mesher> container-test-run-data-mesher> Test will time out and terminate in 3600.0 seconds container-test-run-data-mesher> run the VM test script container-test-run-data-mesher> additionally exposed symbols: container-test-run-data-mesher> alpha, beta, gamma, container-test-run-data-mesher> vlan1, container-test-run-data-mesher> 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-data-mesher> start all VMs container-test-run-data-mesher> alpha: systemd-nspawn running (pid 53) container-test-run-data-mesher> gamma: systemd-nspawn running (pid 54) container-test-run-data-mesher> alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal... container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal... container-test-run-data-mesher> beta: systemd-nspawn running (pid 55) container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/var/log/journal... container-test-run-data-mesher> (finished: start all VMs, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for unit data-mesher.service container-test-run-data-mesher> nixos-nspawn(gamma): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(gamma): 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-data-mesher> nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(alpha): 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-data-mesher> nixos-nspawn(beta): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-data-mesher> nixos-nspawn(beta): 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-data-mesher> 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-data-mesher> 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-data-mesher> ░ Spawning container gamma on /build/vm-state-gamma. container-test-run-data-mesher> ░ Spawning container alpha on /build/vm-state-alpha. container-test-run-data-mesher> 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-data-mesher> ░ Spawning container beta on /build/vm-state-beta. container-test-run-data-mesher> gamma # [540588.658917] gamma systemd-journald[90]: Journal started container-test-run-data-mesher> gamma # [540588.658944] gamma systemd-journald[90]: Runtime Journal (/run/log/journal/65cd3967bd4849e0a7452a4f99efffb0) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> gamma # [540588.664530] gamma systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> alpha # [540588.653623] alpha systemd-journald[90]: Journal started container-test-run-data-mesher> gamma # [540588.670842] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [540588.653653] alpha systemd-journald[90]: Runtime Journal (/run/log/journal/1d51d6850936467bb6c84ce85f47c122) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> gamma # [540588.678623] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> alpha # [540588.657241] alpha systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> gamma # [540588.679045] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> alpha # [540588.663961] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> beta # [540588.662580] beta systemd-journald[90]: Journal started container-test-run-data-mesher> gamma # [540588.679386] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> alpha # [540588.671443] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> gamma # [540588.684100] gamma systemd-journald[90]: Time spent on flushing to /var/log/journal/65cd3967bd4849e0a7452a4f99efffb0 is 1.220ms for 7 entries. container-test-run-data-mesher> gamma # [540588.684100] gamma systemd-journald[90]: System Journal (/var/log/journal/65cd3967bd4849e0a7452a4f99efffb0) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [540588.671860] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [540588.662607] beta systemd-journald[90]: Runtime Journal (/run/log/journal/e137d8be2c174c2ca482675a080f01be) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> alpha # [540588.672214] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [540588.669655] beta systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> beta # [540588.679652] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [540588.676581] alpha systemd-journald[90]: Time spent on flushing to /var/log/journal/1d51d6850936467bb6c84ce85f47c122 is 1.111ms for 7 entries. container-test-run-data-mesher> alpha # [540588.676581] alpha systemd-journald[90]: System Journal (/var/log/journal/1d51d6850936467bb6c84ce85f47c122) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [540588.684704] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [540588.696068] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [540588.696426] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [540588.696749] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [540588.700994] beta systemd-journald[90]: Time spent on flushing to /var/log/journal/e137d8be2c174c2ca482675a080f01be is 1.422ms for 7 entries. container-test-run-data-mesher> beta # [540588.700994] beta systemd-journald[90]: System Journal (/var/log/journal/e137d8be2c174c2ca482675a080f01be) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> alpha # [540588.685040] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [540588.685103] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> beta # [540588.712496] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [540588.713132] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> beta # [540588.713217] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [540588.685583] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [540588.713859] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [540588.713895] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [540588.714482] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [540588.685610] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [540588.714502] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [540588.685979] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> beta # [540588.739258] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> alpha # [540588.685994] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> beta # [540588.740139] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> alpha # [540588.738108] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [540588.768189] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [540588.738643] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [540588.768327] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> beta # [540588.768469] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> beta # [540588.769056] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> beta # [540588.776131] beta systemd-tmpfiles[181]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> beta # [540588.776330] beta systemd-tmpfiles[181]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [540588.776448] beta systemd-tmpfiles[181]: fchmod() of /var/log/journal/e137d8be2c174c2ca482675a080f01be failed: Operation not permitted container-test-run-data-mesher> beta # [540588.776617] beta systemd-tmpfiles[181]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [540588.780163] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [540588.780916] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> beta # [540588.781534] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> beta # [540588.791920] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> beta # [540588.793446] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> beta # [540588.794239] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> beta # [540588.799031] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [540588.768189] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [540588.768351] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [540588.768528] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [540588.769226] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [540588.776046] alpha systemd-tmpfiles[194]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [540588.776197] alpha systemd-tmpfiles[194]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [540588.776327] alpha systemd-tmpfiles[194]: fchmod() of /var/log/journal/1d51d6850936467bb6c84ce85f47c122 failed: Operation not permitted container-test-run-data-mesher> alpha # [540588.776539] alpha systemd-tmpfiles[194]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [540588.780142] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> alpha # [540588.780714] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [540588.781110] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [540588.787736] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> alpha # [540588.793029] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> alpha # [540588.793564] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> alpha # [540588.798408] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [540588.693425] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> gamma # [540588.693790] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> gamma # [540588.693841] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [540588.694282] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> gamma # [540588.694314] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [540588.694678] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [540588.694693] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [540588.739675] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [540588.740308] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [540588.768200] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [540588.768358] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [540588.768542] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> gamma # [540588.769125] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> gamma # [540588.776244] gamma systemd-tmpfiles[185]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [540588.776441] gamma systemd-tmpfiles[185]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [540588.776561] gamma systemd-tmpfiles[185]: fchmod() of /var/log/journal/65cd3967bd4849e0a7452a4f99efffb0 failed: Operation not permitted container-test-run-data-mesher> gamma # [540588.776729] gamma systemd-tmpfiles[185]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [540588.780144] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [540588.780701] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [540588.781120] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [540588.787836] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [540588.796023] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [540588.796534] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [540588.801336] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [540589.305558] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> gamma # [540589.404445] gamma systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [540589.404516] gamma systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [540589.412055] gamma systemd-networkd[200]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> gamma # [540589.412206] gamma systemd-networkd[200]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> gamma # [540589.412265] gamma systemd-networkd[200]: lo: Link UP container-test-run-data-mesher> gamma # [540589.412268] gamma systemd-networkd[200]: lo: Gained carrier container-test-run-data-mesher> gamma # [540589.412390] gamma systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [540589.412613] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [540589.412650] gamma systemd-networkd[200]: eth1: Link UP container-test-run-data-mesher> gamma # [540589.412767] gamma systemd-networkd[200]: eth1: Gained carrier container-test-run-data-mesher> gamma # [540589.413254] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [540589.438185] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> alpha # [540589.305160] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [540589.307463] alpha systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [540589.307558] alpha systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [540589.319296] alpha systemd-networkd[200]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [540589.319499] alpha systemd-networkd[200]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> alpha # [540589.319585] alpha systemd-networkd[200]: lo: Link UP container-test-run-data-mesher> alpha # [540589.319590] alpha systemd-networkd[200]: lo: Gained carrier container-test-run-data-mesher> alpha # [540589.319783] alpha systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [540589.320081] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [540589.320141] alpha systemd-networkd[200]: eth1: Link UP container-test-run-data-mesher> alpha # [540589.320296] alpha systemd-networkd[200]: eth1: Gained carrier container-test-run-data-mesher> alpha # [540589.320893] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [540589.338835] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [540589.305686] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> beta # [540589.419597] beta systemd-networkd[200]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [540589.419676] beta systemd-networkd[200]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [540589.429007] beta systemd-networkd[200]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [540589.429214] beta systemd-networkd[200]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [540589.429293] beta systemd-networkd[200]: lo: Link UP container-test-run-data-mesher> beta # [540589.429297] beta systemd-networkd[200]: lo: Gained carrier container-test-run-data-mesher> beta # [540589.429453] beta systemd-networkd[200]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [540589.429697] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [540589.432132] beta systemd-networkd[200]: eth1: Link UP container-test-run-data-mesher> beta # [540589.432230] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [540589.432291] beta systemd-networkd[200]: eth1: Gained carrier container-test-run-data-mesher> beta # [540589.450482] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [540589.668840] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [540589.859679] beta systemd-resolved[137]: Positive Trust Anchors: container-test-run-data-mesher> beta # [540589.859688] beta systemd-resolved[137]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [540589.859691] beta systemd-resolved[137]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [540589.859706] beta systemd-resolved[137]: 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-data-mesher> beta # [540589.870036] beta systemd-resolved[137]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [540589.870869] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [540589.870917] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [540589.870952] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [540589.870979] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [540589.870992] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [540589.871006] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [540589.871097] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [540589.871161] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [540589.871245] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [540589.871258] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [540589.871282] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [540589.878183] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [540589.878579] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [540589.879048] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [540589.879652] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [540589.888121] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [540589.664517] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> gamma # [540589.847875] gamma systemd-resolved[124]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [540589.847885] gamma systemd-resolved[124]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [540589.847888] gamma systemd-resolved[124]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [540589.847904] gamma systemd-resolved[124]: 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-data-mesher> gamma # [540589.857991] gamma systemd-resolved[124]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [540589.858882] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [540589.858933] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [540589.858968] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [540589.858998] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [540589.859038] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [540589.859048] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [540589.859130] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [540589.859192] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [540589.859256] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [540589.859267] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [540589.859287] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [540589.860038] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [540589.860347] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [540589.860773] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [540589.861426] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [540589.887364] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [540590.016838] gamma nsncd[215]: Oct 15 15:12:10.928 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [540590.016864] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [540590.016917] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [540590.016957] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [540589.655940] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [540589.859799] alpha systemd-resolved[123]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [540589.859807] alpha systemd-resolved[123]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [540589.859809] alpha systemd-resolved[123]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [540589.859826] alpha systemd-resolved[123]: 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-data-mesher> alpha # [540589.870324] alpha systemd-resolved[123]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [540589.871270] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [540589.871320] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [540589.871355] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [540589.871383] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [540589.871398] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [540589.871408] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [540589.871485] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [540589.871553] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [540589.871621] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [540589.871631] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [540589.871651] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [540589.878223] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [540589.878717] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [540589.879130] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [540589.879902] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [540589.890066] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [540590.029221] alpha nsncd[215]: Oct 15 15:12:10.941 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> alpha # [540590.029271] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [540590.029314] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [540590.029347] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [540590.042167] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> alpha # [540590.042571] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> alpha # [540590.049508] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> alpha # [540590.050066] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [540590.050091] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [540590.050103] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> alpha # [540590.241908] alpha dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [540590.243017] alpha dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [540590.243017] alpha dbus-broker-launch[216]: Invalid user-name in /nix/store/q4s51661fyqa8n5v5zsabjbhmbbgwihx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> alpha # [540590.242735] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [540590.246204] alpha dbus-broker-launch[216]: Ready container-test-run-data-mesher> gamma # [540590.017929] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [540590.018336] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [540590.017470] beta nsncd[215]: Oct 15 15:12:10.929 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [540590.046488] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [540590.017525] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [540590.047133] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [540590.017568] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [540590.047153] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [540590.017603] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [540590.047165] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [540590.018473] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [540590.239549] gamma dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [540590.018829] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [540590.240136] gamma dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [540590.045849] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [540590.240136] gamma dbus-broker-launch[216]: Invalid user-name in /nix/store/q4s51661fyqa8n5v5zsabjbhmbbgwihx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [540590.046301] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [540590.240531] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [540590.046322] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [540590.244354] gamma dbus-broker-launch[216]: Ready container-test-run-data-mesher> beta # [540590.046334] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [540590.222709] beta dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [540590.223262] beta dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [540590.223262] beta dbus-broker-launch[216]: Invalid user-name in /nix/store/q4s51661fyqa8n5v5zsabjbhmbbgwihx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [540590.223660] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [540590.227270] beta dbus-broker-launch[216]: Ready container-test-run-data-mesher> beta # [540590.644898] beta data-mesher[213]: time=2026-10-15T15:12:11.557Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> alpha # [540590.604128] alpha data-mesher[213]: time=2026-10-15T15:12:11.516Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [540590.645225] beta data-mesher[213]: time=2026-10-15T15:12:11.557Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP: [/dns/alpha.clan/tcp/7946]} {12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540590.625478] gamma data-mesher[213]: time=2026-10-15T15:12:11.537Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [540590.645225] beta data-mesher[213]: time=2026-10-15T15:12:11.557Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [540590.605420] alpha data-mesher[213]: time=2026-10-15T15:12:11.517Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP: [/dns/alpha.clan/tcp/7946]} {12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> beta # [540590.650167] beta data-mesher[213]: time=2026-10-15T15:12:11.562Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [540590.605420] alpha data-mesher[213]: time=2026-10-15T15:12:11.517Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [540590.650243] beta data-mesher[213]: time=2026-10-15T15:12:11.562Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [540590.621723] alpha data-mesher[213]: time=2026-10-15T15:12:11.533Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [540590.626790] gamma data-mesher[213]: time=2026-10-15T15:12:11.538Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP: [/dns/alpha.clan/tcp/7946]} {12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> alpha # [540590.623073] alpha data-mesher[213]: time=2026-10-15T15:12:11.535Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [540590.626790] gamma data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [540590.625946] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="libp2p host created" peer_id=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.1/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::1/tcp/7946]" container-test-run-data-mesher> gamma # [540590.630479] gamma data-mesher[213]: time=2026-10-15T15:12:11.542Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [540590.626002] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> beta # [540590.652056] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="libp2p host created" peer_id=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.2/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::2/tcp/7946]" container-test-run-data-mesher> alpha # [540590.626002] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> gamma # [540590.630562] gamma data-mesher[213]: time=2026-10-15T15:12:11.542Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [540590.626002] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [540590.652089] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [540590.626002] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [540590.633684] gamma data-mesher[213]: time=2026-10-15T15:12:11.545Z level=INFO msg="libp2p host created" peer_id=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ 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]" container-test-run-data-mesher> alpha # [540590.626141] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [540590.652089] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [540590.626160] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [540590.652089] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [540590.626431] alpha data-mesher[213]: time=2026-10-15T15:12:11.538Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [540590.633728] gamma data-mesher[213]: time=2026-10-15T15:12:11.545Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [540590.654313] alpha data-mesher[213]: time=2026-10-15T15:12:11.566Z level=INFO msg="peer connected" peer_id=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [540590.633728] gamma data-mesher[213]: time=2026-10-15T15:12:11.545Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [540590.782116] alpha systemd-networkd[200]: eth1: Gained IPv6LL container-test-run-data-mesher> gamma # [540590.633728] gamma data-mesher[213]: time=2026-10-15T15:12:11.545Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [540590.827402] alpha systemd-logind[232]: New seat seat0. container-test-run-data-mesher> gamma # [540590.633728] gamma data-mesher[213]: time=2026-10-15T15:12:11.545Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [540590.827559] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> gamma # [540590.633822] gamma data-mesher[213]: time=2026-10-15T15:12:11.546Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [540590.828343] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [540590.633891] gamma data-mesher[213]: time=2026-10-15T15:12:11.546Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> alpha # [540590.835355] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [540590.652089] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [540590.835415] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [540590.633925] gamma data-mesher[213]: time=2026-10-15T15:12:11.546Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [540590.652151] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [540590.654107] gamma systemd-networkd[200]: eth1: Gained IPv6LL container-test-run-data-mesher> beta # [540590.652188] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [540590.805954] gamma systemd-logind[232]: New seat seat0. container-test-run-data-mesher> beta # [540590.652207] beta data-mesher[213]: time=2026-10-15T15:12:11.564Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> gamma # [540590.806105] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [540590.654121] beta data-mesher[213]: time=2026-10-15T15:12:11.566Z level=INFO msg="peer connected" peer_id=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [540590.807120] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [540590.782076] beta systemd-networkd[200]: eth1: Gained IPv6LL container-test-run-data-mesher> gamma # [540590.828525] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [540590.808205] beta systemd-logind[232]: New seat seat0. container-test-run-data-mesher> gamma # [540590.828611] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [540590.808339] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [540590.824243] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [540590.829762] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [540590.829827] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [540591.679742] beta data-mesher[213]: time=2026-10-15T15:12:12.591Z level=INFO msg="peer connected" peer_id=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP remote_addr=/ip6/2001:db8:1::1/tcp/7946 container-test-run-data-mesher> alpha # [540591.679544] alpha data-mesher[213]: time=2026-10-15T15:12:12.591Z level=INFO msg="peer connected" peer_id=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT remote_addr=/ip6/2001:db8:1::2/tcp/7946 container-test-run-data-mesher> gamma # [540595.639714] gamma data-mesher[213]: time=2026-10-15T15:12:16.551Z level=INFO msg="peer connected" peer_id=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [540595.641862] gamma data-mesher[213]: time=2026-10-15T15:12:16.554Z level=INFO msg="peer connected" peer_id=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> beta # [540595.642097] beta data-mesher[213]: time=2026-10-15T15:12:16.554Z level=INFO msg="peer connected" peer_id=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha # [540595.639902] alpha data-mesher[213]: time=2026-10-15T15:12:16.552Z level=INFO msg="peer connected" peer_id=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state... container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 12.64 seconds) container-test-run-data-mesher> beta: waiting for unit data-mesher.service container-test-run-data-mesher> beta: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-data-mesher> gamma: waiting for unit data-mesher.service container-test-run-data-mesher> gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'hello world' > /tmp/test_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key container-test-run-data-mesher> gamma # [540600.627399] gamma data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="received state sync from peer" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540600.627399] gamma data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540600.634847] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> gamma # [540600.634883] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=DEBUG msg="initiating state exchange" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> gamma # [540600.635114] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540600.635114] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="state exchange complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> gamma # [540600.635153] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [540600.635195] gamma data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [540600.635256] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [540600.635390] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> gamma # [540600.635466] gamma systemd[1]: Startup finished in 12.237s. container-test-run-data-mesher> beta # [540600.635068] beta data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="received state sync from peer" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540600.635068] beta data-mesher[213]: time=2026-10-15T15:12:21.547Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540600.652395] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [540600.627088] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [540600.652432] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=DEBUG msg="initiating state exchange" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> alpha # [540600.627088] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540600.652645] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540600.627452] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540600.652645] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="state exchange complete" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> alpha # [540600.627452] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="state exchange complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540600.652702] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="server started" container-test-run-data-mesher> beta # [540600.652724] beta data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> alpha # [540600.627486] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="server started" container-test-run-data-mesher> beta # [540600.652771] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> alpha # [540600.627544] alpha data-mesher[213]: time=2026-10-15T15:12:21.539Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> beta # [540600.652906] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [540600.627616] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [540600.652978] beta systemd[1]: Startup finished in 12.261s. container-test-run-data-mesher> alpha # [540600.627779] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [540600.627864] alpha systemd[1]: Startup finished in 12.240s. container-test-run-data-mesher> alpha # [540600.652581] alpha data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="received state sync from peer" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha # [540600.652581] alpha data-mesher[213]: time=2026-10-15T15:12:21.564Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.18 seconds) container-test-run-data-mesher> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-data-mesher> File "/nix/store/jjnpzllqpcg83qvmj4w6cmqb1zcqvrvl-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-data-mesher> File "/nix/store/jjnpzllqpcg83qvmj4w6cmqb1zcqvrvl-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> alpha # [540600.970444] alpha data-mesher[213]: time=2026-10-15T15:12:21.882Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [540605.638081] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [540605.638081] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=DEBUG msg="initiating state exchange" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> gamma # [540605.638490] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540605.638490] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=DEBUG msg="new file detected" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT name=test_file name=test_file container-test-run-data-mesher> gamma # [540605.638567] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="state exchange complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> gamma # [540605.638567] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [540605.638567] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [540605.638618] gamma data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="downloading file" name=test_file signed_at="2026-10-15 15:12:21.713 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540605.648589] gamma data-mesher[213]: time=2026-10-15T15:12:26.560Z level=INFO msg="download complete" name=test_file signed_at="2026-10-15 15:12:21.713 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT written=true elapsed=10.006168ms container-test-run-data-mesher> gamma # [540605.653519] gamma data-mesher[213]: time=2026-10-15T15:12:26.565Z level=INFO msg="received state sync from peer" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540605.653519] gamma data-mesher[213]: time=2026-10-15T15:12:26.565Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha # [540605.629128] alpha data-mesher[213]: time=2026-10-15T15:12:26.541Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [540605.629636] beta data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="received state sync from peer" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540605.629514] alpha data-mesher[213]: time=2026-10-15T15:12:26.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> beta # [540605.629636] beta data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540605.629758] alpha data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> beta # [540605.629959] beta data-mesher[213]: time=2026-10-15T15:12:26.541Z level=DEBUG msg="new file detected" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP name=test_file name=test_file container-test-run-data-mesher> alpha # [540605.629758] alpha data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="state exchange complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> beta # [540605.629959] beta data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> alpha # [540605.629851] alpha data-mesher[213]: time=2026-10-15T15:12:26.541Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [540605.629959] beta data-mesher[213]: time=2026-10-15T15:12:26.541Z level=INFO msg="downloading file" name=test_file signed_at="2026-10-15 15:12:21.713 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540605.630012] alpha data-mesher[213]: time=2026-10-15T15:12:26.542Z level=INFO msg="received file request" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_file container-test-run-data-mesher> beta # [540605.633145] beta data-mesher[213]: time=2026-10-15T15:12:26.545Z level=INFO msg="download complete" name=test_file signed_at="2026-10-15 15:12:21.713 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP written=true elapsed=3.377622ms container-test-run-data-mesher> alpha # [540605.631077] alpha data-mesher[213]: time=2026-10-15T15:12:26.543Z level=INFO msg="file transfer complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_file container-test-run-data-mesher> beta # [540605.638334] beta data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="received state sync from peer" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540605.638334] beta data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540605.638741] beta data-mesher[213]: time=2026-10-15T15:12:26.550Z level=INFO msg="received file request" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_file container-test-run-data-mesher> beta # [540605.641159] beta data-mesher[213]: time=2026-10-15T15:12:26.553Z level=INFO msg="file transfer complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_file container-test-run-data-mesher> beta # [540605.653121] beta data-mesher[213]: time=2026-10-15T15:12:26.565Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [540605.653411] beta data-mesher[213]: time=2026-10-15T15:12:26.565Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540605.653666] beta data-mesher[213]: time=2026-10-15T15:12:26.565Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540605.653706] beta data-mesher[213]: time=2026-10-15T15:12:26.565Z level=INFO msg="state exchange complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540605.653706] beta data-mesher[213]: time=2026-10-15T15:12:26.565Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 5.02 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key container-test-run-data-mesher> beta: (finished: waiting for success: data-mesher file delete test_file --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.04 seconds) container-test-run-data-mesher> alpha: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> beta # [540606.040611] beta data-mesher[213]: time=2026-10-15T15:12:26.952Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [540610.639235] gamma data-mesher[213]: time=2026-10-15T15:12:31.551Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [540610.639558] gamma data-mesher[213]: time=2026-10-15T15:12:31.551Z level=DEBUG msg="initiating state exchange" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> gamma # [540610.639683] gamma data-mesher[213]: time=2026-10-15T15:12:31.551Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540610.639713] gamma data-mesher[213]: time=2026-10-15T15:12:31.551Z level=INFO msg="state exchange complete" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> gamma # [540610.639713] gamma data-mesher[213]: time=2026-10-15T15:12:31.551Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [540610.654323] gamma data-mesher[213]: time=2026-10-15T15:12:31.566Z level=INFO msg="received state sync from peer" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540610.654323] gamma data-mesher[213]: time=2026-10-15T15:12:31.566Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> gamma # [540610.657483] gamma data-mesher[213]: time=2026-10-15T15:12:31.569Z level=DEBUG msg="imported tombstone" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT name=test_file written=true container-test-run-data-mesher> beta # [540610.630726] beta data-mesher[213]: time=2026-10-15T15:12:31.542Z level=INFO msg="received state sync from peer" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> beta # [540610.630726] beta data-mesher[213]: time=2026-10-15T15:12:31.542Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> beta # [540610.654045] beta data-mesher[213]: time=2026-10-15T15:12:31.566Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [540610.654127] beta data-mesher[213]: time=2026-10-15T15:12:31.566Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540610.657581] beta data-mesher[213]: time=2026-10-15T15:12:31.569Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540610.657640] beta data-mesher[213]: time=2026-10-15T15:12:31.569Z level=INFO msg="state exchange complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540610.657640] beta data-mesher[213]: time=2026-10-15T15:12:31.569Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [540610.630329] alpha data-mesher[213]: time=2026-10-15T15:12:31.542Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [540610.630692] alpha data-mesher[213]: time=2026-10-15T15:12:31.542Z level=DEBUG msg="initiating state exchange" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> alpha # [540610.630810] alpha data-mesher[213]: time=2026-10-15T15:12:31.542Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha # [540610.639559] alpha data-mesher[213]: time=2026-10-15T15:12:31.551Z level=INFO msg="received state sync from peer" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> alpha # [540610.639559] alpha data-mesher[213]: time=2026-10-15T15:12:31.551Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> alpha # [540610.651860] alpha data-mesher[213]: time=2026-10-15T15:12:31.564Z level=DEBUG msg="imported tombstone" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT name=test_file written=true container-test-run-data-mesher> alpha # [540610.651860] alpha data-mesher[213]: time=2026-10-15T15:12:31.564Z level=INFO msg="state exchange complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT timeout=5s container-test-run-data-mesher> alpha # [540610.651949] alpha data-mesher[213]: time=2026-10-15T15:12:31.564Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.02 seconds) container-test-run-data-mesher> beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds) container-test-run-data-mesher> alpha: must succeed: cat /nix/store/67z47jiqyn56hsgv1nsanjb74yw1fc3h-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/67z47jiqyn56hsgv1nsanjb74yw1fc3h-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.00 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.00 seconds) container-test-run-data-mesher> alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.01 seconds) container-test-run-data-mesher> alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha # [540611.088239] alpha data-mesher[213]: time=2026-10-15T15:12:32.000Z level=INFO msg=http_request uri=/files/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI status=204 container-test-run-data-mesher> gamma # [540615.640256] gamma data-mesher[213]: time=2026-10-15T15:12:36.552Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [540615.640256] gamma data-mesher[213]: time=2026-10-15T15:12:36.552Z level=DEBUG msg="initiating state exchange" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> gamma # [540615.640830] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540615.640965] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=DEBUG msg="new file detected" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP name=test_file name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> gamma # [540615.640991] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="state exchange complete" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> gamma # [540615.641025] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="scheduling file download" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> gamma # [540615.641025] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [540615.641071] gamma data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="downloading file" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI signed_at="2026-10-15 15:12:31.999 +0000 UTC" signed_by="ufcoQDSo1IG58d35TTqpAskp74Nxw2hv/agoc/RC2fI=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540615.641848] gamma data-mesher[213]: time=2026-10-15T15:12:36.554Z level=INFO msg="download complete" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI signed_at="2026-10-15 15:12:31.999 +0000 UTC" signed_by="ufcoQDSo1IG58d35TTqpAskp74Nxw2hv/agoc/RC2fI=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP written=true elapsed=816.708µs container-test-run-data-mesher> gamma # [540615.652615] gamma data-mesher[213]: time=2026-10-15T15:12:36.564Z level=INFO msg="received state sync from peer" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> gamma # [540615.652615] gamma data-mesher[213]: time=2026-10-15T15:12:36.564Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> beta # [540615.658521] beta data-mesher[213]: time=2026-10-15T15:12:36.570Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [540615.658521] beta data-mesher[213]: time=2026-10-15T15:12:36.570Z level=DEBUG msg="initiating state exchange" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> beta # [540615.659192] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=INFO msg="merging remote state" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540615.640610] alpha data-mesher[213]: time=2026-10-15T15:12:36.552Z level=INFO msg="received state sync from peer" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540615.659468] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=DEBUG msg="new file detected" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP name=test_file name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha # [540615.640610] alpha data-mesher[213]: time=2026-10-15T15:12:36.552Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> beta # [540615.659468] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=INFO msg="state exchange complete" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP timeout=5s container-test-run-data-mesher> alpha # [540615.641240] alpha data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="received file request" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> beta # [540615.659550] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [540615.641744] alpha data-mesher[213]: time=2026-10-15T15:12:36.553Z level=INFO msg="file transfer complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> beta # [540615.659550] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=INFO msg="scheduling file download" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha # [540615.652369] alpha data-mesher[213]: time=2026-10-15T15:12:36.564Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [540615.659550] beta data-mesher[213]: time=2026-10-15T15:12:36.571Z level=INFO msg="downloading file" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI signed_at="2026-10-15 15:12:31.999 +0000 UTC" signed_by="ufcoQDSo1IG58d35TTqpAskp74Nxw2hv/agoc/RC2fI=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP container-test-run-data-mesher> alpha # [540615.652369] alpha data-mesher[213]: time=2026-10-15T15:12:36.564Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> beta # [540615.661510] beta data-mesher[213]: time=2026-10-15T15:12:36.573Z level=INFO msg="download complete" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI signed_at="2026-10-15 15:12:31.999 +0000 UTC" signed_by="ufcoQDSo1IG58d35TTqpAskp74Nxw2hv/agoc/RC2fI=" peer=12D3KooWNLJBPnQzrRze6LeT1EEA3eWHTi9QCtngv1RXtyhnVzdP written=true elapsed=1.98559ms container-test-run-data-mesher> alpha # [540615.652834] alpha data-mesher[213]: time=2026-10-15T15:12:36.565Z level=INFO msg="merging remote state" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ container-test-run-data-mesher> alpha # [540615.652906] alpha data-mesher[213]: time=2026-10-15T15:12:36.565Z level=INFO msg="state exchange complete" peer=12D3KooWHzB5sRpJC12XQNRGMuDKKY8yG6H8TakPZFqZexP3eyrZ timeout=5s container-test-run-data-mesher> alpha # [540615.652934] alpha data-mesher[213]: time=2026-10-15T15:12:36.565Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [540615.658771] alpha data-mesher[213]: time=2026-10-15T15:12:36.570Z level=INFO msg="received state sync from peer" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha # [540615.658771] alpha data-mesher[213]: time=2026-10-15T15:12:36.570Z level=INFO msg="merging remote state" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT container-test-run-data-mesher> alpha # [540615.659716] alpha data-mesher[213]: time=2026-10-15T15:12:36.571Z level=INFO msg="received file request" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha # [540615.661050] alpha data-mesher[213]: time=2026-10-15T15:12:36.573Z level=INFO msg="file transfer complete" peer=12D3KooWBYcKFPSwHdkiHRyuvRV5PqhPW6kbuWR8sA4cNpkcvVLT network="Wp+Jw+wW9HY+ZHVX5/lB7OO6oPT2BCO00VJe796k3/Q=" name=test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI, in 5.02 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI, in 0.00 seconds) container-test-run-data-mesher> alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert container-test-run-data-mesher> alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.00 seconds) container-test-run-data-mesher> alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer ufcoQDSo1IG58d35TTqpAskp74Nxw2hv/agoc/RC2fI= is not authorized for this file test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/ufcoQDSo1IG58d35TTqpAskp74Nxw2hv_agoc_RC2fI' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/17i6sanqkibk6qbz5iw3j2yfa9hxvbl7-shared-data-mesher-network_network.pub, in 0.01 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 28.01 seconds) container-test-run-data-mesher> test script finished in 28.13s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> kill NspawnMachine (pid 55) container-test-run-data-mesher> kill NspawnMachine (pid 54) container-test-run-data-mesher> Container alpha terminated by signal KILL. container-test-run-data-mesher> Container beta terminated by signal KILL. container-test-run-data-mesher> Container gamma terminated by signal KILL. container-test-run-data-mesher> (finished: cleanup, in 0.21 seconds)