don't know how to build these paths: /nix/store/nss58qzaka9llsn5lgxw7sxcqnxpifj4-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/4hahiz0w65qficn9ysf7lxn5s767vqia-system-path.drv' on nix-store.geninf.io:50051 system-path> build-x86-01: building 4hahiz0w65qficn9ysf7lxn5s767vqia-system-path.drv system-path> structuredAttrs is enabled system-path> created 1723 symlinks in user environment building '/nix/store/frqqbxm8ffwyps2ijs9a30m2pvz0pf26-dbus-1.drv' on nix-store.geninf.io:50051 dbus-1> build-x86-01: building frqqbxm8ffwyps2ijs9a30m2pvz0pf26-dbus-1.drv building '/nix/store/xjg1ppfxz49dx7qlqdzl7ndpnq0gcfcn-X-Restart-Triggers-dbus-broker.drv' on nix-store.geninf.io:50051 X-Restart-Triggers-dbus-broker> build-x86-01: building xjg1ppfxz49dx7qlqdzl7ndpnq0gcfcn-X-Restart-Triggers-dbus-broker.drv X-Restart-Triggers-dbus-broker> structuredAttrs is enabled building '/nix/store/3smgmwqx7zrf3b36yi1r8701096n8b58-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building 3smgmwqx7zrf3b36yi1r8701096n8b58-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/ypjn9brpg3vm8lbwgw58mhibbgfriwp7-unit-dbus-broker.service.drv' on nix-store.geninf.io:50051 unit-dbus-broker.service> build-x86-01: building ypjn9brpg3vm8lbwgw58mhibbgfriwp7-unit-dbus-broker.service.drv unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/v6kdckd2dm1vw1g7h5ay7i5a8zkzqpvf-system-units.drv' on nix-store.geninf.io:50051 system-units> gi-build-x86-02: building v6kdckd2dm1vw1g7h5ay7i5a8zkzqpvf-system-units.drv building '/nix/store/7j7h05yr350nmkgip037knbdmwi9c4fl-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building 7j7h05yr350nmkgip037knbdmwi9c4fl-system-units.drv building '/nix/store/hych8f1dnq25gmkvfk1pr5wypj3fk2mz-system-units.drv' on nix-store.geninf.io:50051 system-units> build-x86-01: building hych8f1dnq25gmkvfk1pr5wypj3fk2mz-system-units.drv building '/nix/store/dwrhpi18qdglg2a2wbm5da0yksyvf4c9-user-units.drv' on nix-store.geninf.io:50051 user-units> build-x86-01: building dwrhpi18qdglg2a2wbm5da0yksyvf4c9-user-units.drv building '/nix/store/7s4p8pk97s56rbhsfxj2hri7jz6iy4z3-etc.drv' on nix-store.geninf.io:50051 etc> gi-build-x86-02: building 7s4p8pk97s56rbhsfxj2hri7jz6iy4z3-etc.drv building '/nix/store/0ng6axhqm9z0spzj5hqqzfiarv28904v-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building 0ng6axhqm9z0spzj5hqqzfiarv28904v-etc.drv building '/nix/store/r49bxpvfk4m4gqvl7vfj53r83ncj3z6q-etc.drv' on nix-store.geninf.io:50051 etc> build-x86-01: building r49bxpvfk4m4gqvl7vfj53r83ncj3z6q-etc.drv building '/nix/store/kznwjd8wbzyiy7ag5gxp6nch9920j7g8-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building kznwjd8wbzyiy7ag5gxp6nch9920j7g8-activate.drv activate> structuredAttrs is enabled building '/nix/store/kkpvk09r3b9v0zmd1f64xiqarirkhs15-activate.drv' on nix-store.geninf.io:50051 activate> build-x86-01: building kkpvk09r3b9v0zmd1f64xiqarirkhs15-activate.drv activate> structuredAttrs is enabled building '/nix/store/i38xf877457ls9lrmm9kzlbkx0q8wz60-activate.drv' on nix-store.geninf.io:50051 activate> gi-build-x86-02: building i38xf877457ls9lrmm9kzlbkx0q8wz60-activate.drv activate> structuredAttrs is enabled building '/nix/store/6mbinn7fasxvr3hmkxq5fj0pw0h5xz7g-nixos-system-alpha-test.drv' on nix-store.geninf.io:50051 nixos-system-alpha-test> gi-build-x86-02: building 6mbinn7fasxvr3hmkxq5fj0pw0h5xz7g-nixos-system-alpha-test.drv nixos-system-alpha-test> structuredAttrs is enabled building '/nix/store/60246x7cdgq13n3qb7qldw0fa1pcissw-nixos-system-gamma-test.drv' on nix-store.geninf.io:50051 nixos-system-gamma-test> build-x86-01: building 60246x7cdgq13n3qb7qldw0fa1pcissw-nixos-system-gamma-test.drv nixos-system-gamma-test> structuredAttrs is enabled building '/nix/store/vg2amfw3iq38pxxiwzfhclgdxi5kzzwz-nixos-system-beta-test.drv' on nix-store.geninf.io:50051 nixos-system-beta-test> build-x86-01: building vg2amfw3iq38pxxiwzfhclgdxi5kzzwz-nixos-system-beta-test.drv nixos-system-beta-test> structuredAttrs is enabled building '/nix/store/9rcxl6kgbgchc9zxd2pffsg1p2d5vc8h-run-gamma-nspawn.drv' on nix-store.geninf.io:50051 run-gamma-nspawn> build-x86-01: building 9rcxl6kgbgchc9zxd2pffsg1p2d5vc8h-run-gamma-nspawn.drv building '/nix/store/r9brylmg2xlcbvflw28cmfv8zkv3qn2p-run-beta-nspawn.drv' on nix-store.geninf.io:50051 run-beta-nspawn> build-x86-01: building r9brylmg2xlcbvflw28cmfv8zkv3qn2p-run-beta-nspawn.drv building '/nix/store/n27s5cfyj9pbgvaqgvl24xvcp6skhs6q-run-alpha-nspawn.drv' on nix-store.geninf.io:50051 run-alpha-nspawn> gi-build-x86-02: building n27s5cfyj9pbgvaqgvl24xvcp6skhs6q-run-alpha-nspawn.drv building '/nix/store/2pk5xmnpwpai6j6nymlibxy6p7dsxijc-driverConfiguration.json.drv' on nix-store.geninf.io:50051 driverConfiguration.json> gi-build-x86-02: building 2pk5xmnpwpai6j6nymlibxy6p7dsxijc-driverConfiguration.json.drv driverConfiguration.json> structuredAttrs is enabled building '/nix/store/6ar5padjrinpbz900g2262xv9scfsi6k-nixos-test-driver-data-mesher.drv' on nix-store.geninf.io:50051 nixos-test-driver-data-mesher> gi-build-x86-02: building 6ar5padjrinpbz900g2262xv9scfsi6k-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/nss58qzaka9llsn5lgxw7sxcqnxpifj4-container-test-run-data-mesher.drv' on nix-store.geninf.io:50051 container-test-run-data-mesher> build-x86-01: building nss58qzaka9llsn5lgxw7sxcqnxpifj4-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 54) container-test-run-data-mesher> beta: systemd-nspawn running (pid 53) container-test-run-data-mesher> gamma: 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> 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> (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> beta # [2170151.860463] beta systemd-journald[91]: Journal started container-test-run-data-mesher> beta # [2170151.860490] beta systemd-journald[91]: Runtime Journal (/run/log/journal/85a4e754fcd44beb86487552689a9aee) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> beta # [2170151.863455] beta systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> beta # [2170151.870573] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> alpha # [2170151.859281] alpha systemd-journald[90]: Journal started container-test-run-data-mesher> beta # [2170151.877874] beta systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [2170151.878205] beta systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [2170151.878469] beta systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [2170151.883855] beta systemd-journald[91]: Time spent on flushing to /var/log/journal/85a4e754fcd44beb86487552689a9aee is 1.094ms for 7 entries. container-test-run-data-mesher> beta # [2170151.883855] beta systemd-journald[91]: System Journal (/var/log/journal/85a4e754fcd44beb86487552689a9aee) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2170151.900595] beta systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [2170151.900874] beta systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> alpha # [2170151.859313] alpha systemd-journald[90]: Runtime Journal (/run/log/journal/d37c0365eec34573b217dccb1bd343aa) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> beta # [2170151.901785] beta systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> alpha # [2170151.863445] alpha systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> beta # [2170151.901849] beta systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> alpha # [2170151.869794] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> beta # [2170151.902296] beta systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> alpha # [2170151.877375] alpha systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> beta # [2170151.902323] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [2170151.877716] alpha systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> beta # [2170151.902723] beta systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> alpha # [2170151.878037] alpha systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> beta # [2170151.903006] beta systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> alpha # [2170151.881728] alpha systemd-journald[90]: Time spent on flushing to /var/log/journal/d37c0365eec34573b217dccb1bd343aa is 1.032ms for 7 entries. container-test-run-data-mesher> beta # [2170151.903023] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> alpha # [2170151.881728] alpha systemd-journald[90]: System Journal (/var/log/journal/d37c0365eec34573b217dccb1bd343aa) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> beta # [2170151.911864] beta systemd-tmpfiles[154]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2170151.900732] alpha systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> beta # [2170151.912030] beta systemd-tmpfiles[154]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [2170151.901255] alpha systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> beta # [2170151.912139] beta systemd-tmpfiles[154]: fchmod() of /var/log/journal/85a4e754fcd44beb86487552689a9aee failed: Operation not permitted container-test-run-data-mesher> alpha # [2170151.902482] alpha systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> beta # [2170151.912285] beta systemd-tmpfiles[154]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> alpha # [2170151.902545] alpha systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> beta # [2170151.913398] beta systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> alpha # [2170151.903162] alpha systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> beta # [2170151.914096] beta systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> alpha # [2170151.903200] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [2170151.914505] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [2170151.903700] alpha systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> beta # [2170151.920841] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> alpha # [2170151.904264] alpha systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> beta # [2170151.928527] beta systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> alpha # [2170151.904284] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> beta # [2170151.929239] beta systemd[1]: Starting Update is Completed... container-test-run-data-mesher> alpha # [2170151.913388] alpha systemd-tmpfiles[154]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> beta # [2170151.934655] beta systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [2170151.913529] alpha systemd-tmpfiles[154]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [2170151.947647] beta systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [2170151.913628] alpha systemd-tmpfiles[154]: fchmod() of /var/log/journal/d37c0365eec34573b217dccb1bd343aa failed: Operation not permitted container-test-run-data-mesher> beta # [2170151.949842] beta systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [2170151.913775] alpha systemd-tmpfiles[154]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> beta # [2170151.949924] beta systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [2170151.914563] alpha systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> beta # [2170151.950057] beta systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [2170151.915046] alpha systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> beta # [2170151.950546] beta systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [2170151.915362] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> alpha # [2170151.921545] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> alpha # [2170151.928221] alpha systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> alpha # [2170151.928658] alpha systemd[1]: Starting Update is Completed... container-test-run-data-mesher> alpha # [2170151.933405] alpha systemd[1]: Finished Update is Completed. container-test-run-data-mesher> alpha # [2170151.947184] alpha systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> alpha # [2170151.951640] alpha systemd[1]: Finished Firewall. container-test-run-data-mesher> alpha # [2170151.951718] alpha systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> alpha # [2170151.951840] alpha systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> alpha # [2170151.952243] alpha systemd[1]: Starting Network Management... container-test-run-data-mesher> gamma # [2170151.859328] gamma systemd-journald[90]: Journal started container-test-run-data-mesher> gamma # [2170151.859354] gamma systemd-journald[90]: Runtime Journal (/run/log/journal/aa2235029a214570b0e3f772290b2b60) is 8M, max 3.7G, 3.7G free. container-test-run-data-mesher> gamma # [2170151.864832] gamma systemd[1]: Finished Apply Kernel Variables. container-test-run-data-mesher> gamma # [2170151.871121] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-data-mesher> gamma # [2170151.878386] gamma systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-data-mesher> gamma # [2170151.878699] gamma systemd[1]: Starting Network Name Resolution... container-test-run-data-mesher> gamma # [2170151.878954] gamma systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-data-mesher> gamma # [2170151.882822] gamma systemd-journald[90]: Time spent on flushing to /var/log/journal/aa2235029a214570b0e3f772290b2b60 is 1.475ms for 7 entries. container-test-run-data-mesher> gamma # [2170151.882822] gamma systemd-journald[90]: System Journal (/var/log/journal/aa2235029a214570b0e3f772290b2b60) is 8M, max 4G, 3.9G free. container-test-run-data-mesher> gamma # [2170151.896659] gamma systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-data-mesher> gamma # [2170151.896837] gamma systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-data-mesher> gamma # [2170151.897365] gamma systemd[1]: Reached target Preparation for Local File Systems. container-test-run-data-mesher> gamma # [2170151.897428] gamma systemd[1]: Reached target Local File Systems. container-test-run-data-mesher> gamma # [2170151.897838] gamma systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-data-mesher> gamma # [2170151.897869] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [2170151.898212] gamma systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-data-mesher> gamma # [2170151.898524] gamma systemd[1]: Starting Create System Files and Directories... container-test-run-data-mesher> gamma # [2170151.898539] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-data-mesher> gamma # [2170151.907118] gamma systemd-tmpfiles[151]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2170151.907258] gamma systemd-tmpfiles[151]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2170151.907357] gamma systemd-tmpfiles[151]: fchmod() of /var/log/journal/aa2235029a214570b0e3f772290b2b60 failed: Operation not permitted container-test-run-data-mesher> gamma # [2170151.907504] gamma systemd-tmpfiles[151]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-data-mesher> gamma # [2170151.908254] gamma systemd[1]: Finished Create System Files and Directories. container-test-run-data-mesher> gamma # [2170151.908680] gamma systemd[1]: Starting Rebuild Journal Catalog... container-test-run-data-mesher> gamma # [2170151.908989] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-data-mesher> gamma # [2170151.915267] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-data-mesher> gamma # [2170151.920709] gamma systemd[1]: Finished Rebuild Journal Catalog. container-test-run-data-mesher> gamma # [2170151.921234] gamma systemd[1]: Starting Update is Completed... container-test-run-data-mesher> gamma # [2170151.928080] gamma systemd[1]: Finished Update is Completed. container-test-run-data-mesher> gamma # [2170151.947356] gamma systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-data-mesher> gamma # [2170151.947580] gamma systemd[1]: Finished Firewall. container-test-run-data-mesher> gamma # [2170151.947916] gamma systemd[1]: Reached target Preparation for Network. container-test-run-data-mesher> gamma # [2170151.948076] gamma systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-data-mesher> gamma # [2170151.948520] gamma systemd[1]: Starting Network Management... container-test-run-data-mesher> alpha # [2170152.451341] alpha systemd-networkd[208]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2170152.451411] alpha systemd-networkd[208]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> alpha # [2170152.459137] alpha systemd-networkd[208]: /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 # [2170152.459281] alpha systemd-networkd[208]: /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 # [2170152.459351] alpha systemd-networkd[208]: lo: Link UP container-test-run-data-mesher> alpha # [2170152.459355] alpha systemd-networkd[208]: lo: Gained carrier container-test-run-data-mesher> alpha # [2170152.459496] alpha systemd-networkd[208]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> alpha # [2170152.459741] alpha systemd[1]: Started Network Management. container-test-run-data-mesher> alpha # [2170152.459777] alpha systemd-networkd[208]: eth1: Link UP container-test-run-data-mesher> alpha # [2170152.459926] alpha systemd-networkd[208]: eth1: Gained carrier container-test-run-data-mesher> alpha # [2170152.460405] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> alpha # [2170152.481949] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> beta # [2170152.452905] beta systemd-networkd[209]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [2170152.452971] beta systemd-networkd[209]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> beta # [2170152.460665] beta systemd-networkd[209]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [2170152.460808] beta systemd-networkd[209]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-data-mesher> beta # [2170152.460862] beta systemd-networkd[209]: lo: Link UP container-test-run-data-mesher> beta # [2170152.460865] beta systemd-networkd[209]: lo: Gained carrier container-test-run-data-mesher> beta # [2170152.460970] beta systemd-networkd[209]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> beta # [2170152.461192] beta systemd[1]: Started Network Management. container-test-run-data-mesher> beta # [2170152.461227] beta systemd-networkd[209]: eth1: Link UP container-test-run-data-mesher> beta # [2170152.461360] beta systemd-networkd[209]: eth1: Gained carrier container-test-run-data-mesher> beta # [2170152.461726] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> beta # [2170152.488084] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> gamma # [2170152.463567] gamma systemd-networkd[208]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2170152.463645] gamma systemd-networkd[208]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-data-mesher> gamma # [2170152.471196] gamma systemd-networkd[208]: /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 # [2170152.471341] gamma systemd-networkd[208]: /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 # [2170152.471392] gamma systemd-networkd[208]: lo: Link UP container-test-run-data-mesher> gamma # [2170152.471395] gamma systemd-networkd[208]: lo: Gained carrier container-test-run-data-mesher> gamma # [2170152.471505] gamma systemd-networkd[208]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-data-mesher> gamma # [2170152.471704] gamma systemd[1]: Started Network Management. container-test-run-data-mesher> gamma # [2170152.477091] gamma systemd-networkd[208]: eth1: Link UP container-test-run-data-mesher> gamma # [2170152.477158] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-data-mesher> gamma # [2170152.477204] gamma systemd-networkd[208]: eth1: Gained carrier container-test-run-data-mesher> gamma # [2170152.499034] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-data-mesher> alpha # [2170152.822159] alpha systemd-resolved[123]: Positive Trust Anchors: container-test-run-data-mesher> alpha # [2170152.822167] alpha systemd-resolved[123]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> alpha # [2170152.822169] alpha systemd-resolved[123]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> alpha # [2170152.822186] 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 # [2170152.833441] alpha systemd-resolved[123]: Using system hostname 'alpha'. container-test-run-data-mesher> alpha # [2170152.834432] alpha systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> alpha # [2170152.834502] alpha systemd[1]: Reached target Network. container-test-run-data-mesher> alpha # [2170152.834547] alpha systemd[1]: Reached target System Initialization. container-test-run-data-mesher> alpha # [2170152.834587] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> alpha # [2170152.834611] alpha systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> alpha # [2170152.834623] alpha systemd[1]: Reached target Timer Units. container-test-run-data-mesher> alpha # [2170152.834727] alpha systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> alpha # [2170152.834817] alpha systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> alpha # [2170152.834911] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> alpha # [2170152.834926] alpha systemd[1]: Reached target Socket Units. container-test-run-data-mesher> alpha # [2170152.834951] alpha systemd[1]: Reached target Basic System. container-test-run-data-mesher> alpha # [2170152.835813] alpha systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> alpha # [2170152.836237] alpha systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> alpha # [2170152.836674] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> alpha # [2170152.837426] alpha systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> alpha # [2170152.857563] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> alpha # [2170152.864132] alpha systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> alpha # [2170152.991067] alpha nsncd[215]: Sep 29 10:06:07.414 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> alpha # [2170152.991110] alpha systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> alpha # [2170152.991151] alpha systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> alpha # [2170152.991188] alpha systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> alpha # [2170152.991759] alpha systemd[1]: Starting User Login Management... container-test-run-data-mesher> alpha # [2170152.992081] alpha systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> alpha # [2170153.022450] alpha systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> alpha # [2170153.023146] alpha systemd[1]: Started Console Getty. container-test-run-data-mesher> alpha # [2170153.023172] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> alpha # [2170153.023184] alpha systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> alpha # [2170153.095057] alpha dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> alpha # [2170153.095553] alpha dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> alpha # [2170153.095553] alpha dbus-broker-launch[216]: Invalid user-name in /nix/store/fc8qbsv0zlqqf1izmih9zjaaqhl7bvfa-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> gamma # [2170152.858574] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> gamma # [2170152.880270] gamma systemd-resolved[124]: Positive Trust Anchors: container-test-run-data-mesher> gamma # [2170152.880277] gamma systemd-resolved[124]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> gamma # [2170152.880280] gamma systemd-resolved[124]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> gamma # [2170152.880297] 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 # [2170152.890672] gamma systemd-resolved[124]: Using system hostname 'gamma'. container-test-run-data-mesher> gamma # [2170152.891582] gamma systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> gamma # [2170152.891639] gamma systemd[1]: Reached target Network. container-test-run-data-mesher> gamma # [2170152.891684] gamma systemd[1]: Reached target System Initialization. container-test-run-data-mesher> gamma # [2170152.891721] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> gamma # [2170152.891740] gamma systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> gamma # [2170152.891752] gamma systemd[1]: Reached target Timer Units. container-test-run-data-mesher> gamma # [2170152.891849] gamma systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> gamma # [2170152.891928] gamma systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> gamma # [2170152.892028] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> gamma # [2170152.892042] gamma systemd[1]: Reached target Socket Units. container-test-run-data-mesher> gamma # [2170152.892072] gamma systemd[1]: Reached target Basic System. container-test-run-data-mesher> gamma # [2170152.893372] gamma systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> gamma # [2170152.893902] gamma systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> gamma # [2170152.894432] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> gamma # [2170152.895181] gamma systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> gamma # [2170152.905081] gamma systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> gamma # [2170153.012625] gamma nsncd[215]: Sep 29 10:06:07.435 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> gamma # [2170153.012699] gamma systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> gamma # [2170153.012748] gamma systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> gamma # [2170153.012779] gamma systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> gamma # [2170153.017236] gamma systemd[1]: Starting User Login Management... container-test-run-data-mesher> gamma # [2170153.017971] gamma systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> gamma # [2170153.023816] gamma systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> gamma # [2170153.024334] gamma systemd[1]: Started Console Getty. container-test-run-data-mesher> gamma # [2170153.024356] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> gamma # [2170153.024366] gamma systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> gamma # [2170153.119789] gamma dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> gamma # [2170153.120268] gamma dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> gamma # [2170153.120268] gamma dbus-broker-launch[216]: Invalid user-name in /nix/store/fc8qbsv0zlqqf1izmih9zjaaqhl7bvfa-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [2170152.858048] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-data-mesher> beta # [2170152.858900] beta systemd-resolved[124]: Positive Trust Anchors: container-test-run-data-mesher> beta # [2170152.858907] beta systemd-resolved[124]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-data-mesher> beta # [2170152.858910] beta systemd-resolved[124]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-data-mesher> beta # [2170152.858926] beta 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> beta # [2170152.869944] beta systemd-resolved[124]: Using system hostname 'beta'. container-test-run-data-mesher> beta # [2170152.870866] beta systemd[1]: Started Network Name Resolution. container-test-run-data-mesher> beta # [2170152.870921] beta systemd[1]: Reached target Network. container-test-run-data-mesher> beta # [2170152.870964] beta systemd[1]: Reached target System Initialization. container-test-run-data-mesher> beta # [2170152.871006] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-data-mesher> beta # [2170152.871025] beta systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-data-mesher> beta # [2170152.871037] beta systemd[1]: Reached target Timer Units. container-test-run-data-mesher> beta # [2170152.871132] beta systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-data-mesher> beta # [2170152.871206] beta systemd[1]: Listening on Nix Daemon Socket. container-test-run-data-mesher> beta # [2170152.871288] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-data-mesher> beta # [2170152.871304] beta systemd[1]: Reached target Socket Units. container-test-run-data-mesher> beta # [2170152.871333] beta systemd[1]: Reached target Basic System. container-test-run-data-mesher> beta # [2170152.872480] beta systemd[1]: Starting data mesher daemon... container-test-run-data-mesher> beta # [2170152.872900] beta systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-data-mesher> beta # [2170152.873296] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-data-mesher> beta # [2170152.873872] beta systemd[1]: Starting D-Bus System Message Bus... container-test-run-data-mesher> beta # [2170152.882070] beta systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-data-mesher> beta # [2170152.990324] beta nsncd[216]: Sep 29 10:06:07.413 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-data-mesher> beta # [2170152.990350] beta systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-data-mesher> beta # [2170152.990388] beta systemd[1]: Reached target Host and Network Name Lookups. container-test-run-data-mesher> beta # [2170152.990424] beta systemd[1]: Reached target User and Group Name Lookups. container-test-run-data-mesher> beta # [2170152.991166] beta systemd[1]: Starting User Login Management... container-test-run-data-mesher> beta # [2170152.991600] beta systemd[1]: Starting Permit User Sessions... container-test-run-data-mesher> beta # [2170153.023204] beta systemd[1]: Finished Permit User Sessions. container-test-run-data-mesher> beta # [2170153.023789] beta systemd[1]: Started Console Getty. container-test-run-data-mesher> beta # [2170153.023812] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-data-mesher> beta # [2170153.023822] beta systemd[1]: Reached target Login Prompts. container-test-run-data-mesher> beta # [2170153.142486] beta dbus-broker-launch[217]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-data-mesher> beta # [2170153.142828] beta dbus-broker-launch[217]: NSS returned no entry for 'systemd-timesync' container-test-run-data-mesher> beta # [2170153.142828] beta dbus-broker-launch[217]: Invalid user-name in /nix/store/fc8qbsv0zlqqf1izmih9zjaaqhl7bvfa-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-data-mesher> beta # [2170153.143043] beta systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> beta # [2170153.146615] beta dbus-broker-launch[217]: Ready container-test-run-data-mesher> gamma # [2170153.120656] gamma systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> gamma # [2170153.124114] gamma dbus-broker-launch[216]: Ready container-test-run-data-mesher> alpha # [2170153.095846] alpha systemd[1]: Started D-Bus System Message Bus. container-test-run-data-mesher> alpha # [2170153.099288] alpha dbus-broker-launch[216]: Ready container-test-run-data-mesher> alpha # [2170153.424626] alpha data-mesher[213]: time=2026-09-29T10:06:07.847Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> alpha # [2170153.424903] alpha data-mesher[213]: time=2026-09-29T10:06:07.848Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW: [/dns/alpha.clan/tcp/7946]} {12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> alpha # [2170153.424921] alpha data-mesher[213]: time=2026-09-29T10:06:07.848Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> alpha # [2170153.425990] alpha data-mesher[213]: time=2026-09-29T10:06:07.849Z level=INFO msg="checking file integrity" container-test-run-data-mesher> alpha # [2170153.426077] alpha data-mesher[213]: time=2026-09-29T10:06:07.849Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> alpha # [2170153.427859] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="libp2p host created" peer_id=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW 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> alpha # [2170153.427889] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> alpha # [2170153.427889] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> alpha # [2170153.427889] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> alpha # [2170153.427889] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="starting server" container-test-run-data-mesher> alpha # [2170153.427989] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> alpha # [2170153.427989] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> alpha # [2170153.428038] alpha data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> alpha # [2170153.431479] alpha data-mesher[213]: time=2026-09-29T10:06:07.854Z level=INFO msg="peer connected" peer_id=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> alpha # [2170153.434663] alpha data-mesher[213]: time=2026-09-29T10:06:07.857Z level=INFO msg="peer connected" peer_id=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> alpha # [2170153.590436] alpha systemd-logind[232]: New seat seat0. container-test-run-data-mesher> alpha # [2170153.590538] alpha systemd[1]: Started User Login Management. container-test-run-data-mesher> alpha # [2170153.598215] alpha systemd[1]: Starting linger-users.service... container-test-run-data-mesher> alpha # [2170153.605337] alpha systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> alpha # [2170153.605406] alpha systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [2170153.424607] gamma data-mesher[213]: time=2026-09-29T10:06:07.847Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> gamma # [2170153.424903] gamma data-mesher[213]: time=2026-09-29T10:06:07.848Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW: [/dns/alpha.clan/tcp/7946]} {12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> gamma # [2170153.424921] gamma data-mesher[213]: time=2026-09-29T10:06:07.848Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> gamma # [2170153.425819] gamma data-mesher[213]: time=2026-09-29T10:06:07.849Z level=INFO msg="checking file integrity" container-test-run-data-mesher> gamma # [2170153.425879] gamma data-mesher[213]: time=2026-09-29T10:06:07.849Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> gamma # [2170153.428242] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="libp2p host created" peer_id=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 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> gamma # [2170153.428267] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> gamma # [2170153.428267] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> gamma # [2170153.428267] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> gamma # [2170153.428267] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="starting server" container-test-run-data-mesher> gamma # [2170153.428327] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> gamma # [2170153.428340] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> gamma # [2170153.428360] gamma data-mesher[213]: time=2026-09-29T10:06:07.851Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> gamma # [2170153.431165] gamma data-mesher[213]: time=2026-09-29T10:06:07.854Z level=INFO msg="peer connected" peer_id=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> gamma # [2170153.436289] gamma data-mesher[213]: time=2026-09-29T10:06:07.859Z level=INFO msg="peer connected" peer_id=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-data-mesher> gamma # [2170153.576724] gamma systemd-logind[232]: New seat seat0. container-test-run-data-mesher> gamma # [2170153.576836] gamma systemd[1]: Started User Login Management. container-test-run-data-mesher> gamma # [2170153.577540] gamma systemd[1]: Starting linger-users.service... container-test-run-data-mesher> gamma # [2170153.602427] gamma systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> gamma # [2170153.602498] gamma systemd[1]: Finished linger-users.service. container-test-run-data-mesher> gamma # [2170153.792067] gamma systemd-networkd[208]: eth1: Gained IPv6LL container-test-run-data-mesher> beta # [2170153.429024] beta data-mesher[214]: time=2026-09-29T10:06:07.852Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-data-mesher> beta # [2170153.430081] beta data-mesher[214]: time=2026-09-29T10:06:07.853Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW: [/dns/alpha.clan/tcp/7946]} {12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> beta # [2170153.430081] beta data-mesher[214]: time=2026-09-29T10:06:07.853Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-data-mesher> beta # [2170153.430671] beta data-mesher[214]: time=2026-09-29T10:06:07.854Z level=INFO msg="checking file integrity" container-test-run-data-mesher> beta # [2170153.430748] beta data-mesher[214]: time=2026-09-29T10:06:07.854Z level=INFO msg="file integrity check complete" container-test-run-data-mesher> beta # [2170153.432761] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="libp2p host created" peer_id=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx 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> beta # [2170153.432797] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-data-mesher> beta # [2170153.432797] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-data-mesher> beta # [2170153.432797] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-data-mesher> beta # [2170153.432797] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="starting server" container-test-run-data-mesher> beta # [2170153.432877] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-data-mesher> beta # [2170153.432877] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-data-mesher> beta # [2170153.432877] beta data-mesher[214]: time=2026-09-29T10:06:07.856Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-data-mesher> beta # [2170153.434492] beta data-mesher[214]: time=2026-09-29T10:06:07.857Z level=INFO msg="peer connected" peer_id=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-data-mesher> beta # [2170153.436110] beta data-mesher[214]: time=2026-09-29T10:06:07.859Z level=INFO msg="peer connected" peer_id=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-data-mesher> beta # [2170153.595176] beta systemd-logind[233]: New seat seat0. container-test-run-data-mesher> beta # [2170153.595284] beta systemd[1]: Started User Login Management. container-test-run-data-mesher> beta # [2170153.598248] beta systemd[1]: Starting linger-users.service... container-test-run-data-mesher> beta # [2170153.603882] beta systemd[1]: linger-users.service: Deactivated successfully. container-test-run-data-mesher> beta # [2170153.603966] beta systemd[1]: Finished linger-users.service. container-test-run-data-mesher> beta # [2170153.664100] beta systemd-networkd[209]: eth1: Gained IPv6LL container-test-run-data-mesher> alpha # [2170153.792107] alpha systemd-networkd[208]: eth1: Gained IPv6LL 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.14 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/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.02 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/ww1fp9ch7b86riwmzgb57p620cz6f717-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/ww1fp9ch7b86riwmzgb57p620cz6f717-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> beta # [2170163.431105] beta data-mesher[214]: time=2026-09-29T10:06:17.854Z level=INFO msg="received state sync from peer" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170163.431105] beta data-mesher[214]: time=2026-09-29T10:06:17.854Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170163.433370] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> beta # [2170163.433398] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170163.433533] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170163.433533] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170163.433557] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=INFO msg="server started" container-test-run-data-mesher> beta # [2170163.433614] beta data-mesher[214]: time=2026-09-29T10:06:17.856Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> beta # [2170163.433662] beta systemd[1]: Started data mesher daemon. container-test-run-data-mesher> beta # [2170163.433785] beta systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> beta # [2170163.433856] beta systemd[1]: Startup finished in 11.820s. container-test-run-data-mesher> gamma # [2170163.430791] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> gamma # [2170163.431086] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170163.431131] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170163.431131] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170163.431158] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="server started" container-test-run-data-mesher> gamma # [2170163.431218] gamma data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> gamma # [2170163.431278] gamma systemd[1]: Started data mesher daemon. container-test-run-data-mesher> gamma # [2170163.431461] gamma systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> gamma # [2170163.431545] gamma systemd[1]: Startup finished in 11.818s. container-test-run-data-mesher> alpha # [2170163.430776] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-data-mesher> alpha # [2170163.430776] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=DEBUG msg="initiating state exchange" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> alpha # [2170163.431172] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="received state sync from peer" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170163.431172] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170163.431172] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170163.431172] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="state exchange complete" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> alpha # [2170163.431172] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="server started" container-test-run-data-mesher> alpha # [2170163.431277] alpha data-mesher[213]: time=2026-09-29T10:06:17.854Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-data-mesher> alpha # [2170163.431301] alpha systemd[1]: Started data mesher daemon. container-test-run-data-mesher> alpha # [2170163.431440] alpha systemd[1]: Reached target Multi-User System. container-test-run-data-mesher> alpha # [2170163.431538] alpha systemd[1]: Startup finished in 11.818s. container-test-run-data-mesher> alpha # [2170163.433490] alpha data-mesher[213]: time=2026-09-29T10:06:17.856Z level=INFO msg="received state sync from peer" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170163.433490] alpha data-mesher[213]: time=2026-09-29T10:06:17.856Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170163.507715] alpha data-mesher[213]: time=2026-09-29T10:06:17.931Z level=INFO msg=http_request uri=/files/test_file status=204 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/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-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/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.01 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 # [2170168.432549] beta data-mesher[214]: time=2026-09-29T10:06:22.855Z level=INFO msg="received state sync from peer" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170168.432549] beta data-mesher[214]: time=2026-09-29T10:06:22.855Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170168.432549] beta data-mesher[214]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="new file detected" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file name=test_file container-test-run-data-mesher> beta # [2170168.432953] beta data-mesher[214]: time=2026-09-29T10:06:22.855Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> beta # [2170168.432953] beta data-mesher[214]: time=2026-09-29T10:06:22.855Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-29 10:06:17.923 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170168.434178] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2170168.434463] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170168.434463] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170168.434463] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=DEBUG msg="new file detected" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file name=test_file container-test-run-data-mesher> beta # [2170168.434463] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170168.434463] beta data-mesher[214]: time=2026-09-29T10:06:22.857Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [2170168.435205] beta data-mesher[214]: time=2026-09-29T10:06:22.858Z level=INFO msg="download complete" name=test_file signed_at="2026-09-29 10:06:17.923 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW written=true elapsed=2.567126ms container-test-run-data-mesher> beta # [2170168.548988] beta data-mesher[214]: time=2026-09-29T10:06:22.972Z level=INFO msg=http_request uri=/files/test_file status=204 container-test-run-data-mesher> gamma # [2170168.432077] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2170168.432376] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170168.432535] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170168.432563] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="new file detected" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file name=test_file container-test-run-data-mesher> gamma # [2170168.432563] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170168.432563] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2170168.432606] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="scheduling file download" name=test_file container-test-run-data-mesher> gamma # [2170168.432606] gamma data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-29 10:06:17.923 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170168.434763] gamma data-mesher[213]: time=2026-09-29T10:06:22.858Z level=INFO msg="download complete" name=test_file signed_at="2026-09-29 10:06:17.923 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW written=true elapsed=2.169276ms container-test-run-data-mesher> alpha # [2170168.432129] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2170168.432129] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="initiating state exchange" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> alpha # [2170168.432513] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="received state sync from peer" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170168.432513] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170168.432647] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170168.432647] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=INFO msg="state exchange complete" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> alpha # [2170168.432749] alpha data-mesher[213]: time=2026-09-29T10:06:22.855Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2170168.432787] alpha data-mesher[213]: time=2026-09-29T10:06:22.856Z level=INFO msg="received file request" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_file container-test-run-data-mesher> alpha # [2170168.432882] alpha data-mesher[213]: time=2026-09-29T10:06:22.856Z level=INFO msg="received file request" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_file container-test-run-data-mesher> alpha # [2170168.433651] alpha data-mesher[213]: time=2026-09-29T10:06:22.856Z level=INFO msg="file transfer complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_file container-test-run-data-mesher> alpha # [2170168.434189] alpha data-mesher[213]: time=2026-09-29T10:06:22.857Z level=INFO msg="file transfer complete" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_file container-test-run-data-mesher> alpha # [2170168.434464] alpha data-mesher[213]: time=2026-09-29T10:06:22.857Z level=INFO msg="received state sync from peer" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170168.434464] alpha data-mesher[213]: time=2026-09-29T10:06:22.857Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx 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> beta # [2170173.435077] beta data-mesher[214]: time=2026-09-29T10:06:27.858Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2170173.435077] beta data-mesher[214]: time=2026-09-29T10:06:27.858Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170173.439773] beta data-mesher[214]: time=2026-09-29T10:06:27.863Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> beta # [2170173.439773] beta data-mesher[214]: time=2026-09-29T10:06:27.863Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> beta # [2170173.439861] beta data-mesher[214]: time=2026-09-29T10:06:27.863Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2170173.433239] gamma data-mesher[213]: time=2026-09-29T10:06:27.856Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2170173.433553] gamma data-mesher[213]: time=2026-09-29T10:06:27.856Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170173.433553] gamma data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="received state sync from peer" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170173.433553] gamma data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170173.433685] gamma data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170173.433685] gamma data-mesher[213]: time=2026-09-29T10:06:27.857Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170173.433771] gamma data-mesher[213]: time=2026-09-29T10:06:27.857Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2170173.433242] alpha data-mesher[213]: time=2026-09-29T10:06:27.856Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2170173.433529] alpha data-mesher[213]: time=2026-09-29T10:06:27.856Z level=DEBUG msg="initiating state exchange" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170173.433529] alpha data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="received state sync from peer" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170173.433529] alpha data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170173.433670] alpha data-mesher[213]: time=2026-09-29T10:06:27.856Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170173.433724] alpha data-mesher[213]: time=2026-09-29T10:06:27.857Z level=INFO msg="state exchange complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170173.433724] alpha data-mesher[213]: time=2026-09-29T10:06:27.857Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2170173.435309] alpha data-mesher[213]: time=2026-09-29T10:06:27.858Z level=INFO msg="received state sync from peer" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170173.435309] alpha data-mesher[213]: time=2026-09-29T10:06:27.858Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170173.439670] alpha data-mesher[213]: time=2026-09-29T10:06:27.862Z level=DEBUG msg="imported tombstone" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx name=test_file written=true container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.02 seconds) container-test-run-data-mesher> alpha: must succeed: cat /nix/store/5mxmkj5v8fryzrf5d971w6yf8l6asbjv-per-machine-alpha-data-mesher-node-identity_identity.pub container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/5mxmkj5v8fryzrf5d971w6yf8l6asbjv-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/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-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/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-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/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8, in 0.00 seconds) container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> beta # [2170178.440178] beta data-mesher[214]: time=2026-09-29T10:06:32.863Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2170178.440178] beta data-mesher[214]: time=2026-09-29T10:06:32.863Z level=DEBUG msg="initiating state exchange" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> beta # [2170178.440474] beta data-mesher[214]: time=2026-09-29T10:06:32.863Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> beta # [2170178.440500] beta data-mesher[214]: time=2026-09-29T10:06:32.863Z level=INFO msg="state exchange complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> beta # [2170178.440500] beta data-mesher[214]: time=2026-09-29T10:06:32.863Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2170178.433969] gamma data-mesher[213]: time=2026-09-29T10:06:32.857Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2170178.433969] gamma data-mesher[213]: time=2026-09-29T10:06:32.857Z level=DEBUG msg="initiating state exchange" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170178.434396] gamma data-mesher[213]: time=2026-09-29T10:06:32.857Z level=INFO msg="received state sync from peer" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170178.434396] gamma data-mesher[213]: time=2026-09-29T10:06:32.857Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170178.434499] gamma data-mesher[213]: time=2026-09-29T10:06:32.857Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170178.435178] gamma data-mesher[213]: time=2026-09-29T10:06:32.858Z level=DEBUG msg="imported tombstone" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file written=true container-test-run-data-mesher> gamma # [2170178.435224] gamma data-mesher[213]: time=2026-09-29T10:06:32.858Z level=DEBUG msg="imported tombstone" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file written=false container-test-run-data-mesher> gamma # [2170178.435224] gamma data-mesher[213]: time=2026-09-29T10:06:32.858Z level=INFO msg="state exchange complete" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW timeout=5s container-test-run-data-mesher> gamma # [2170178.435260] gamma data-mesher[213]: time=2026-09-29T10:06:32.858Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2170178.440390] gamma data-mesher[213]: time=2026-09-29T10:06:32.863Z level=INFO msg="received state sync from peer" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> gamma # [2170178.440390] gamma data-mesher[213]: time=2026-09-29T10:06:32.863Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> alpha # [2170178.434048] alpha data-mesher[213]: time=2026-09-29T10:06:32.857Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2170178.434048] alpha data-mesher[213]: time=2026-09-29T10:06:32.857Z level=DEBUG msg="initiating state exchange" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170178.434386] alpha data-mesher[213]: time=2026-09-29T10:06:32.857Z level=INFO msg="received state sync from peer" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170178.434386] alpha data-mesher[213]: time=2026-09-29T10:06:32.857Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170178.435240] alpha data-mesher[213]: time=2026-09-29T10:06:32.858Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170178.435279] alpha data-mesher[213]: time=2026-09-29T10:06:32.858Z level=INFO msg="state exchange complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170178.435279] alpha data-mesher[213]: time=2026-09-29T10:06:32.858Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2170178.610259] alpha data-mesher[213]: time=2026-09-29T10:06:33.033Z level=INFO msg=http_request uri=/files/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 status=204 container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8, in 5.02 seconds) container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8, 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/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-shared-data-mesher-network_network.pub container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer Z/cE2vt+KtztNU8S+rzRi3Gh7LzGShm4reOLGr/EeM8= is not authorized for this file test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/x80fd27h9vflnbw8a6h43fhxlr7pj5l1-shared-data-mesher-network_network.pub, in 0.01 seconds) container-test-run-data-mesher> (finished: run the VM test script, in 32.33 seconds) container-test-run-data-mesher> test script finished in 32.34s container-test-run-data-mesher> cleanup container-test-run-data-mesher> kill NspawnMachine (pid 54) container-test-run-data-mesher> alpha # [2170183.436120] alpha data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> alpha # [2170183.436120] alpha data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="initiating state exchange" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170183.436585] alpha data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> alpha # [2170183.436607] alpha data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="state exchange complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> alpha # [2170183.436625] alpha data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> alpha # [2170183.436688] alpha data-mesher[213]: time=2026-09-29T10:06:37.860Z level=INFO msg="received file request" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> alpha # [2170183.437550] alpha data-mesher[213]: time=2026-09-29T10:06:37.860Z level=INFO msg="file transfer complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> alpha # [2170183.654240] alpha data-mesher[213]: time=2026-09-29T10:06:38.077Z level=INFO msg=http_request uri=/files/test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 status=403 container-test-run-data-mesher> alpha # [2170183.672575] alpha systemd-networkd[208]: eth1: Link DOWN container-test-run-data-mesher> alpha # [2170183.672583] alpha systemd-networkd[208]: eth1: Lost carrier container-test-run-data-mesher> alpha # [2170183.692207] alpha systemd-networkd[208]: eth1: Lost IPv6LL address fe80::44cc:91ff:fec7:fe9b. container-test-run-data-mesher> kill NspawnMachine (pid 53) container-test-run-data-mesher> beta # [2170183.436134] beta data-mesher[214]: time=2026-09-29T10:06:37.859Z level=INFO msg="received state sync from peer" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> beta # [2170183.436134] beta data-mesher[214]: time=2026-09-29T10:06:37.859Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> beta # [2170183.440559] beta data-mesher[214]: time=2026-09-29T10:06:37.863Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> beta # [2170183.440596] beta data-mesher[214]: time=2026-09-29T10:06:37.863Z level=DEBUG msg="initiating state exchange" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> beta # [2170183.440874] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=INFO msg="merging remote state" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> beta # [2170183.440942] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=DEBUG msg="new file detected" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 name=test_file name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> beta # [2170183.440964] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=INFO msg="state exchange complete" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 timeout=5s container-test-run-data-mesher> beta # [2170183.440964] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> beta # [2170183.440964] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=INFO msg="scheduling file download" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> beta # [2170183.441030] beta data-mesher[214]: time=2026-09-29T10:06:37.864Z level=INFO msg="downloading file" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 signed_at="2026-09-29 10:06:33.032 +0000 UTC" signed_by="Z/cE2vt+KtztNU8S+rzRi3Gh7LzGShm4reOLGr/EeM8=" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 container-test-run-data-mesher> beta # [2170183.442264] beta data-mesher[214]: time=2026-09-29T10:06:37.865Z level=INFO msg="download complete" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 signed_at="2026-09-29 10:06:33.032 +0000 UTC" signed_by="Z/cE2vt+KtztNU8S+rzRi3Gh7LzGShm4reOLGr/EeM8=" peer=12D3KooWB4uTAiyw73MGv7sFWMkDynq4cArxMtPgxfTLXtco3h32 written=true elapsed=1.281864ms container-test-run-data-mesher> Container alpha terminated by signal KILL. container-test-run-data-mesher> kill NspawnMachine (pid 55) container-test-run-data-mesher> gamma # [2170183.435908] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-data-mesher> gamma # [2170183.435908] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="initiating state exchange" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> gamma # [2170183.436237] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> gamma # [2170183.436237] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="state exchange complete" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx timeout=5s container-test-run-data-mesher> gamma # [2170183.436237] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-data-mesher> gamma # [2170183.436397] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="received state sync from peer" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170183.436397] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="merging remote state" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170183.436477] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=DEBUG msg="new file detected" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW name=test_file name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> gamma # [2170183.436541] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="scheduling file download" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> gamma # [2170183.436576] gamma data-mesher[213]: time=2026-09-29T10:06:37.859Z level=INFO msg="downloading file" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 signed_at="2026-09-29 10:06:33.032 +0000 UTC" signed_by="Z/cE2vt+KtztNU8S+rzRi3Gh7LzGShm4reOLGr/EeM8=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW container-test-run-data-mesher> gamma # [2170183.437876] gamma data-mesher[213]: time=2026-09-29T10:06:37.861Z level=INFO msg="download complete" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 signed_at="2026-09-29 10:06:33.032 +0000 UTC" signed_by="Z/cE2vt+KtztNU8S+rzRi3Gh7LzGShm4reOLGr/EeM8=" peer=12D3KooWGpCdHpUMk3FwLya6jT8TrVw1VmjM7YtF4WySBDuozoEW written=true elapsed=1.326799ms container-test-run-data-mesher> gamma # [2170183.440731] gamma data-mesher[213]: time=2026-09-29T10:06:37.864Z level=INFO msg="received state sync from peer" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> gamma # [2170183.440731] gamma data-mesher[213]: time=2026-09-29T10:06:37.864Z level=INFO msg="merging remote state" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx container-test-run-data-mesher> gamma # [2170183.441160] gamma data-mesher[213]: time=2026-09-29T10:06:37.864Z level=INFO msg="received file request" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 container-test-run-data-mesher> gamma # [2170183.441918] gamma data-mesher[213]: time=2026-09-29T10:06:37.865Z level=INFO msg="file transfer complete" peer=12D3KooWSvoU6jtzGU5uQadNSSg9kLGao7KWm2SyjBcFJe98NBRx network="rjPllgJ8V8fMMBBBvxlrSDfmaMcAbRK815EpdPU51GU=" name=test_ns/Z_cE2vt-KtztNU8S-rzRi3Gh7LzGShm4reOLGr_EeM8 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.29 seconds)