these 27 derivations will be built:
  /nix/store/12q2vaszslk1n82ypz3wb7yzn8cdrr5f-nix.conf.drv
  /nix/store/i42amyz3kdn12p0zbx8vs2v91dpar8s9-system-path.drv
  /nix/store/acyvv30m8a0273nbravy2brvmzd6cyn1-dbus-1.drv
  /nix/store/2wwsdilh463psdk8jq03wnhwdgkf1akg-X-Restart-Triggers-dbus-broker.drv
  /nix/store/apwsb8kabiwvpmh8lxbp301hfp34mp7a-unit-dbus-broker.service.drv
  /nix/store/79qazm4jfhhy7dz9lyj3rgwgjcr3f7v3-user-units.drv
  /nix/store/r2l3fdmx6x8jz6vsh4n1qa61l6gf90wg-system-units.drv
  /nix/store/857jlhjsirima1ad15hzsiwlpjqfp986-etc.drv
  /nix/store/08snd4qj1ffxszk7kwrzmcq00m5m8d49-activate.drv
  /nix/store/42d3xjnz5jvxqz1rn5wrk01p9mdil880-nixos-system-alpha-test.drv
  /nix/store/5cvdxw2kanb7i0b6vzljs0fw9w6m7m5n-etc.drv
  /nix/store/7vijx49i5ffamhfzl7b6dx4jnqdzzn05-nixos-system-beta-test.drv
  /nix/store/rxvqmqqbyzf4748kg6n01kbi07hwr5zv-X-Restart-Triggers-nix-daemon.drv
  /nix/store/95cqz2cx0dcrn4b7vkv8ryj7ry5abp2i-unit-nix-daemon.service.drv
  /nix/store/ravhijgl2zdyhwnskwwjy8f1mpv7jzd8-unit-dbus-broker.service.drv
  /nix/store/q14nnqj4vhr06ls2m356xzjpgb8pm3h7-system-units.drv
  /nix/store/b6jd5cdk72kzav6lypcq6h5yfbi6jifh-etc.drv
  /nix/store/fxzdrhrb4d5bjpvndgvny91gs2qkmv7r-container-test-run-data-mesher.drv
  /nix/store/gk8nz2adgz7g77avwvf6vj82ry23dpvn-nixos-system-gamma-test.drv
  /nix/store/l98l7qfihzmb2a9r6l8bh10xq6scxm36-driverConfiguration.json.drv
  /nix/store/pxnypfqsq9mkzb76hrrj39zjqkqxdlhx-activate.drv
  /nix/store/rihksbvnf38mqddw7y9kwy2994655zxl-activate.drv
  /nix/store/s94cvphyvic1nbicl1jwdwi4zvg5cnys-nixos-test-driver-data-mesher.drv
  /nix/store/sddz7cdyypqbcbsavzrmzbgzszqanrl5-system-units.drv
  /nix/store/v96amdhqvqz8z39zraxnrxy9qm4ysnbm-run-gamma-nspawn.drv
  /nix/store/v9p8h9l4cbklqvdphdh8likamdv9zs9w-run-beta-nspawn.drv
  /nix/store/xgwwhz4jn3dsbbnd8qj8k3kmrl6p0f5k-run-alpha-nspawn.drv
warning: ignoring the client-specified setting 'store', because it is a restricted setting and you are not a trusted user
building '/nix/store/q14nnqj4vhr06ls2m356xzjpgb8pm3h7-system-units.drv' on nix-store.geninf.io:50051
system-units> web01: building q14nnqj4vhr06ls2m356xzjpgb8pm3h7-system-units.drv
building '/nix/store/b6jd5cdk72kzav6lypcq6h5yfbi6jifh-etc.drv' on nix-store.geninf.io:50051
etc> web01: building b6jd5cdk72kzav6lypcq6h5yfbi6jifh-etc.drv
building '/nix/store/pxnypfqsq9mkzb76hrrj39zjqkqxdlhx-activate.drv' on nix-store.geninf.io:50051
activate> web01: building pxnypfqsq9mkzb76hrrj39zjqkqxdlhx-activate.drv
activate> structuredAttrs is enabled
building '/nix/store/gk8nz2adgz7g77avwvf6vj82ry23dpvn-nixos-system-gamma-test.drv' on nix-store.geninf.io:50051
nixos-system-gamma-test> web01: building gk8nz2adgz7g77avwvf6vj82ry23dpvn-nixos-system-gamma-test.drv
nixos-system-gamma-test> structuredAttrs is enabled
building '/nix/store/v96amdhqvqz8z39zraxnrxy9qm4ysnbm-run-gamma-nspawn.drv' on nix-store.geninf.io:50051
run-gamma-nspawn> web01: building v96amdhqvqz8z39zraxnrxy9qm4ysnbm-run-gamma-nspawn.drv
building '/nix/store/r2l3fdmx6x8jz6vsh4n1qa61l6gf90wg-system-units.drv' on nix-store.geninf.io:50051
system-units> gi-build-x86-02: building r2l3fdmx6x8jz6vsh4n1qa61l6gf90wg-system-units.drv
building '/nix/store/sddz7cdyypqbcbsavzrmzbgzszqanrl5-system-units.drv' on nix-store.geninf.io:50051
system-units> build-x86-01: building sddz7cdyypqbcbsavzrmzbgzszqanrl5-system-units.drv
building '/nix/store/857jlhjsirima1ad15hzsiwlpjqfp986-etc.drv' on nix-store.geninf.io:50051
etc> gi-build-x86-02: building 857jlhjsirima1ad15hzsiwlpjqfp986-etc.drv
building '/nix/store/08snd4qj1ffxszk7kwrzmcq00m5m8d49-activate.drv' on nix-store.geninf.io:50051
activate> gi-build-x86-01: building 08snd4qj1ffxszk7kwrzmcq00m5m8d49-activate.drv
activate> structuredAttrs is enabled
building '/nix/store/5cvdxw2kanb7i0b6vzljs0fw9w6m7m5n-etc.drv' on nix-store.geninf.io:50051
etc> build-x86-01: building 5cvdxw2kanb7i0b6vzljs0fw9w6m7m5n-etc.drv
building '/nix/store/7vijx49i5ffamhfzl7b6dx4jnqdzzn05-nixos-system-beta-test.drv' on nix-store.geninf.io:50051
nixos-system-beta-test> build-x86-01: building 7vijx49i5ffamhfzl7b6dx4jnqdzzn05-nixos-system-beta-test.drv
nixos-system-beta-test> structuredAttrs is enabled
building '/nix/store/rihksbvnf38mqddw7y9kwy2994655zxl-activate.drv' on nix-store.geninf.io:50051
activate> build-x86-01: building rihksbvnf38mqddw7y9kwy2994655zxl-activate.drv
activate> structuredAttrs is enabled
building '/nix/store/v9p8h9l4cbklqvdphdh8likamdv9zs9w-run-beta-nspawn.drv' on nix-store.geninf.io:50051
run-beta-nspawn> build-x86-01: building v9p8h9l4cbklqvdphdh8likamdv9zs9w-run-beta-nspawn.drv
building '/nix/store/42d3xjnz5jvxqz1rn5wrk01p9mdil880-nixos-system-alpha-test.drv' on nix-store.geninf.io:50051
nixos-system-alpha-test> build-x86-01: building 42d3xjnz5jvxqz1rn5wrk01p9mdil880-nixos-system-alpha-test.drv
nixos-system-alpha-test> structuredAttrs is enabled
building '/nix/store/xgwwhz4jn3dsbbnd8qj8k3kmrl6p0f5k-run-alpha-nspawn.drv' on nix-store.geninf.io:50051
run-alpha-nspawn> build-x86-01: building xgwwhz4jn3dsbbnd8qj8k3kmrl6p0f5k-run-alpha-nspawn.drv
building '/nix/store/l98l7qfihzmb2a9r6l8bh10xq6scxm36-driverConfiguration.json.drv' on nix-store.geninf.io:50051
driverConfiguration.json> build-x86-01: building l98l7qfihzmb2a9r6l8bh10xq6scxm36-driverConfiguration.json.drv
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/s94cvphyvic1nbicl1jwdwi4zvg5cnys-nixos-test-driver-data-mesher.drv' on nix-store.geninf.io:50051
nixos-test-driver-data-mesher> build-x86-01: building s94cvphyvic1nbicl1jwdwi4zvg5cnys-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/fxzdrhrb4d5bjpvndgvny91gs2qkmv7r-container-test-run-data-mesher.drv' on nix-store.geninf.io:50051
container-test-run-data-mesher> build-x86-01: building fxzdrhrb4d5bjpvndgvny91gs2qkmv7r-container-test-run-data-mesher.drv
container-test-run-data-mesher> Machine state will be reset. To keep it, pass --keep-machine-state
container-test-run-data-mesher> start all VLans
container-test-run-data-mesher> (finished: start all VLans, in 0.00 seconds)
container-test-run-data-mesher> 
container-test-run-data-mesher> Test will time out and terminate in 3600.0 seconds
container-test-run-data-mesher> run the VM test script
container-test-run-data-mesher> additionally exposed symbols:
container-test-run-data-mesher>     alpha, beta, gamma,
container-test-run-data-mesher>     vlan1,
container-test-run-data-mesher>     start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh
container-test-run-data-mesher> start all VMs
container-test-run-data-mesher> alpha: systemd-nspawn running (pid 53)
container-test-run-data-mesher> beta: systemd-nspawn running (pid 54)
container-test-run-data-mesher> gamma: systemd-nspawn running (pid 55)
container-test-run-data-mesher> alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal...
container-test-run-data-mesher> gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal...
container-test-run-data-mesher> beta: Waiting for journal at /build/vm-state-beta/var/log/journal...
container-test-run-data-mesher> (finished: start all VMs, in 0.00 seconds)
container-test-run-data-mesher> alpha: waiting for unit data-mesher.service
container-test-run-data-mesher> nixos-nspawn(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(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(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> 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> ░ Spawning container beta on /build/vm-state-beta.
container-test-run-data-mesher> alpha # [2843382.336268] alpha systemd-journald[90]: Journal started
container-test-run-data-mesher> alpha # [2843382.336302] alpha systemd-journald[90]: Runtime Journal (/run/log/journal/50289288859c442f843d9b381e96e857) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> alpha # [2843382.340043] alpha systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> alpha # [2843382.346403] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> alpha # [2843382.353672] alpha systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> beta # [2843382.334355] beta systemd-journald[90]: Journal started
container-test-run-data-mesher> alpha # [2843382.354116] alpha systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> beta # [2843382.334382] beta systemd-journald[90]: Runtime Journal (/run/log/journal/6896f7d9ba574fc5895e70c53ee1c91e) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> alpha # [2843382.354455] alpha systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> beta # [2843382.338951] beta systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> alpha # [2843382.381892] alpha systemd-journald[90]: Time spent on flushing to /var/log/journal/50289288859c442f843d9b381e96e857 is 1.119ms for 7 entries.
container-test-run-data-mesher> beta # [2843382.346467] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> alpha # [2843382.381892] alpha systemd-journald[90]: System Journal (/var/log/journal/50289288859c442f843d9b381e96e857) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> beta # [2843382.354354] beta systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> alpha # [2843382.393928] alpha systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> beta # [2843382.354763] beta systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> alpha # [2843382.394517] alpha systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> beta # [2843382.355107] beta systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> alpha # [2843382.395842] alpha systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> beta # [2843382.381331] beta systemd-journald[90]: Time spent on flushing to /var/log/journal/6896f7d9ba574fc5895e70c53ee1c91e is 1.004ms for 7 entries.
container-test-run-data-mesher> alpha # [2843382.395905] alpha systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> beta # [2843382.381331] beta systemd-journald[90]: System Journal (/var/log/journal/6896f7d9ba574fc5895e70c53ee1c91e) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> gamma # [2843382.333763] gamma systemd-journald[90]: Journal started
container-test-run-data-mesher> beta # [2843382.392952] beta systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> alpha # [2843382.396521] alpha systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> gamma # [2843382.333795] gamma systemd-journald[90]: Runtime Journal (/run/log/journal/4e2978595276425782c5b4213f234c0a) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> alpha # [2843382.396556] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [2843382.394486] beta systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> gamma # [2843382.341319] gamma systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> beta # [2843382.395141] beta systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> alpha # [2843382.397160] alpha systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> gamma # [2843382.348252] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> alpha # [2843382.397637] alpha systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> beta # [2843382.395203] beta systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> gamma # [2843382.355754] gamma systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> beta # [2843382.395636] beta systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> alpha # [2843382.397655] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> gamma # [2843382.378268] gamma systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> alpha # [2843382.411206] alpha systemd-tmpfiles[167]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [2843382.395671] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [2843382.378682] gamma systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> beta # [2843382.396141] beta systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> alpha # [2843382.411365] alpha systemd-tmpfiles[167]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> gamma # [2843382.381880] gamma systemd-journald[90]: Time spent on flushing to /var/log/journal/4e2978595276425782c5b4213f234c0a is 1.140ms for 7 entries.
container-test-run-data-mesher> alpha # [2843382.411465] alpha systemd-tmpfiles[167]: fchmod() of /var/log/journal/50289288859c442f843d9b381e96e857 failed: Operation not permitted
container-test-run-data-mesher> beta # [2843382.396499] beta systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> gamma # [2843382.381880] gamma systemd-journald[90]: System Journal (/var/log/journal/4e2978595276425782c5b4213f234c0a) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> beta # [2843382.396513] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> alpha # [2843382.411613] alpha systemd-tmpfiles[167]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [2843382.405474] beta systemd-tmpfiles[168]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [2843382.399882] gamma systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> beta # [2843382.405618] beta systemd-tmpfiles[168]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [2843382.412533] alpha systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> gamma # [2843382.400097] gamma systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> alpha # [2843382.413054] alpha systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> beta # [2843382.405719] beta systemd-tmpfiles[168]: fchmod() of /var/log/journal/6896f7d9ba574fc5895e70c53ee1c91e failed: Operation not permitted
container-test-run-data-mesher> gamma # [2843382.401184] gamma systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> beta # [2843382.405864] beta systemd-tmpfiles[168]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [2843382.413331] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> gamma # [2843382.401242] gamma systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> alpha # [2843382.419743] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> beta # [2843382.408753] beta systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> gamma # [2843382.401674] gamma systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> beta # [2843382.409178] beta systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> alpha # [2843382.425816] alpha systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> gamma # [2843382.401701] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> alpha # [2843382.425946] alpha systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> beta # [2843382.409482] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> alpha # [2843382.426915] alpha systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> gamma # [2843382.402125] gamma systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> alpha # [2843382.432563] alpha systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> beta # [2843382.416514] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> gamma # [2843382.402443] gamma systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> beta # [2843382.421833] beta systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> alpha # [2843382.433944] alpha systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [2843382.402457] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> alpha # [2843382.434011] alpha systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> gamma # [2843382.414065] gamma systemd-tmpfiles[175]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [2843382.422629] beta systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> alpha # [2843382.434154] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> gamma # [2843382.414211] gamma systemd-tmpfiles[175]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [2843382.425833] beta systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> gamma # [2843382.414310] gamma systemd-tmpfiles[175]: fchmod() of /var/log/journal/4e2978595276425782c5b4213f234c0a failed: Operation not permitted
container-test-run-data-mesher> alpha # [2843382.434711] alpha systemd[1]: Starting Network Management...
container-test-run-data-mesher> beta # [2843382.428254] beta systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> gamma # [2843382.414462] gamma systemd-tmpfiles[175]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [2843382.431220] beta systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [2843382.421623] gamma systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> beta # [2843382.431280] beta systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> gamma # [2843382.423515] gamma systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> beta # [2843382.431404] beta systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> gamma # [2843382.423978] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> gamma # [2843382.424940] gamma systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> beta # [2843382.431811] beta systemd[1]: Starting Network Management...
container-test-run-data-mesher> gamma # [2843382.429150] gamma systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [2843382.429208] gamma systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> gamma # [2843382.429347] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> gamma # [2843382.429902] gamma systemd[1]: Starting Network Management...
container-test-run-data-mesher> gamma # [2843382.431370] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> gamma # [2843382.438161] gamma systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> gamma # [2843382.438621] gamma systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> gamma # [2843382.444378] gamma systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> gamma # [2843382.889841] gamma systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [2843382.889917] gamma systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [2843382.897510] gamma systemd-networkd[204]: /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 # [2843382.897648] gamma systemd-networkd[204]: /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 # [2843382.897734] gamma systemd-networkd[204]: lo: Link UP
container-test-run-data-mesher> gamma # [2843382.897737] gamma systemd-networkd[204]: lo: Gained carrier
container-test-run-data-mesher> gamma # [2843382.897890] gamma systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> gamma # [2843382.898138] gamma systemd[1]: Started Network Management.
container-test-run-data-mesher> gamma # [2843382.898183] gamma systemd-networkd[204]: eth1: Link UP
container-test-run-data-mesher> gamma # [2843382.898346] gamma systemd-networkd[204]: eth1: Gained carrier
container-test-run-data-mesher> gamma # [2843382.898872] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> gamma # [2843382.925808] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> beta # [2843382.894441] beta systemd-networkd[208]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [2843382.894503] beta systemd-networkd[208]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [2843382.901121] beta 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> beta # [2843382.901264] beta 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> beta # [2843382.901328] beta systemd-networkd[208]: lo: Link UP
container-test-run-data-mesher> beta # [2843382.901330] beta systemd-networkd[208]: lo: Gained carrier
container-test-run-data-mesher> beta # [2843382.901452] beta systemd-networkd[208]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> beta # [2843382.901661] beta systemd[1]: Started Network Management.
container-test-run-data-mesher> beta # [2843382.921160] beta systemd-networkd[208]: eth1: Link UP
container-test-run-data-mesher> beta # [2843382.921171] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> beta # [2843382.921358] beta systemd-networkd[208]: eth1: Gained carrier
container-test-run-data-mesher> beta # [2843382.938233] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> alpha # [2843382.899989] alpha systemd-networkd[208]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [2843382.900062] alpha systemd-networkd[208]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [2843382.907038] 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 # [2843382.907178] 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 # [2843382.907239] alpha systemd-networkd[208]: lo: Link UP
container-test-run-data-mesher> alpha # [2843382.907242] alpha systemd-networkd[208]: lo: Gained carrier
container-test-run-data-mesher> alpha # [2843382.907356] alpha systemd-networkd[208]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> alpha # [2843382.907572] alpha systemd[1]: Started Network Management.
container-test-run-data-mesher> alpha # [2843382.921171] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> alpha # [2843382.921190] alpha systemd-networkd[208]: eth1: Link UP
container-test-run-data-mesher> alpha # [2843382.921366] alpha systemd-networkd[208]: eth1: Gained carrier
container-test-run-data-mesher> alpha # [2843382.939146] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> alpha # [2843383.248038] alpha systemd-resolved[124]: Positive Trust Anchors:
container-test-run-data-mesher> alpha # [2843383.248045] alpha systemd-resolved[124]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> alpha # [2843383.248048] alpha systemd-resolved[124]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> alpha # [2843383.248064] alpha 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> alpha # [2843383.258434] alpha systemd-resolved[124]: Using system hostname 'alpha'.
container-test-run-data-mesher> alpha # [2843383.259275] alpha systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> alpha # [2843383.259325] alpha systemd[1]: Reached target Network.
container-test-run-data-mesher> alpha # [2843383.259360] alpha systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> alpha # [2843383.259393] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> alpha # [2843383.259410] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> alpha # [2843383.259417] alpha systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> alpha # [2843383.259492] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> alpha # [2843383.259550] alpha systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> alpha # [2843383.259619] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> alpha # [2843383.259630] alpha systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> alpha # [2843383.259651] alpha systemd[1]: Reached target Basic System.
container-test-run-data-mesher> alpha # [2843383.260361] alpha systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> alpha # [2843383.260706] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> alpha # [2843383.261092] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> alpha # [2843383.261704] alpha systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> alpha # [2843383.290764] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> alpha # [2843383.333214] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> alpha # [2843383.418441] alpha nsncd[215]: Oct 07 05:06:37.841 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> alpha # [2843383.418448] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> alpha # [2843383.418474] alpha systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> alpha # [2843383.418502] alpha systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> alpha # [2843383.436167] alpha systemd[1]: Starting User Login Management...
container-test-run-data-mesher> alpha # [2843383.436549] alpha systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> alpha # [2843383.442201] alpha systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> alpha # [2843383.442623] alpha systemd[1]: Started Console Getty.
container-test-run-data-mesher> alpha # [2843383.442648] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> alpha # [2843383.442658] alpha systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> alpha # [2843383.527513] alpha dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> gamma # [2843383.261991] gamma systemd-resolved[126]: Positive Trust Anchors:
container-test-run-data-mesher> gamma # [2843383.261999] gamma systemd-resolved[126]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> gamma # [2843383.262009] gamma systemd-resolved[126]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> gamma # [2843383.262025] gamma systemd-resolved[126]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
container-test-run-data-mesher> gamma # [2843383.272542] gamma systemd-resolved[126]: Using system hostname 'gamma'.
container-test-run-data-mesher> gamma # [2843383.273442] gamma systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> gamma # [2843383.273490] gamma systemd[1]: Reached target Network.
container-test-run-data-mesher> gamma # [2843383.273526] gamma systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> gamma # [2843383.273557] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [2843383.273573] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> gamma # [2843383.273583] gamma systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> gamma # [2843383.273664] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> gamma # [2843383.273732] gamma systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> gamma # [2843383.273799] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> gamma # [2843383.273808] gamma systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> gamma # [2843383.273831] gamma systemd[1]: Reached target Basic System.
container-test-run-data-mesher> gamma # [2843383.281224] gamma systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> gamma # [2843383.282335] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> gamma # [2843383.283067] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> gamma # [2843383.283931] gamma systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> gamma # [2843383.292542] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> gamma # [2843383.331122] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> gamma # [2843383.413649] gamma nsncd[215]: Oct 07 05:06:37.836 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> gamma # [2843383.413685] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> gamma # [2843383.413714] gamma systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> gamma # [2843383.413748] gamma systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> gamma # [2843383.414267] gamma systemd[1]: Starting User Login Management...
container-test-run-data-mesher> gamma # [2843383.414560] gamma systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> gamma # [2843383.440636] gamma systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> gamma # [2843383.441502] gamma systemd[1]: Started Console Getty.
container-test-run-data-mesher> gamma # [2843383.441530] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> gamma # [2843383.441544] gamma systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> gamma # [2843383.529735] gamma dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> gamma # [2843383.530140] gamma dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> gamma # [2843383.530140] gamma dbus-broker-launch[216]: Invalid user-name in /nix/store/4m5mcf8469vmgqbb8n76j0jbihri7hja-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> beta # [2843383.260948] beta systemd-resolved[125]: Positive Trust Anchors:
container-test-run-data-mesher> beta # [2843383.260956] beta systemd-resolved[125]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> beta # [2843383.260959] beta systemd-resolved[125]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> beta # [2843383.260975] beta systemd-resolved[125]: 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 # [2843383.271299] beta systemd-resolved[125]: Using system hostname 'beta'.
container-test-run-data-mesher> beta # [2843383.272087] beta systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> beta # [2843383.272127] beta systemd[1]: Reached target Network.
container-test-run-data-mesher> beta # [2843383.272165] beta systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> beta # [2843383.272197] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [2843383.272214] beta systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> beta # [2843383.272222] beta systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> beta # [2843383.272291] beta systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> beta # [2843383.272351] beta systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> beta # [2843383.272422] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> beta # [2843383.272434] beta systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> beta # [2843383.272454] beta systemd[1]: Reached target Basic System.
container-test-run-data-mesher> beta # [2843383.281214] beta systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> beta # [2843383.281732] beta systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> beta # [2843383.282236] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> beta # [2843383.283014] beta systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> beta # [2843383.292463] beta systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> beta # [2843383.331811] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> beta # [2843383.413297] beta nsncd[215]: Oct 07 05:06:37.836 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> beta # [2843383.413293] beta systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> beta # [2843383.413318] beta systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> beta # [2843383.413347] beta systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> beta # [2843383.413915] beta systemd[1]: Starting User Login Management...
container-test-run-data-mesher> beta # [2843383.414257] beta systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> beta # [2843383.440323] beta systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> beta # [2843383.440732] beta systemd[1]: Started Console Getty.
container-test-run-data-mesher> beta # [2843383.440752] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> beta # [2843383.440762] beta systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> beta # [2843383.531956] beta dbus-broker-launch[216]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> alpha # [2843383.528223] alpha dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> alpha # [2843383.528223] alpha dbus-broker-launch[216]: Invalid user-name in /nix/store/4m5mcf8469vmgqbb8n76j0jbihri7hja-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> alpha # [2843383.528623] alpha systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> alpha # [2843383.534021] alpha dbus-broker-launch[216]: Ready
container-test-run-data-mesher> beta # [2843383.532414] beta dbus-broker-launch[216]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> beta # [2843383.532414] beta dbus-broker-launch[216]: Invalid user-name in /nix/store/4m5mcf8469vmgqbb8n76j0jbihri7hja-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> beta # [2843383.532642] beta systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> beta # [2843383.536143] beta dbus-broker-launch[216]: Ready
container-test-run-data-mesher> gamma # [2843383.530369] gamma systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> gamma # [2843383.534470] gamma dbus-broker-launch[216]: Ready
container-test-run-data-mesher> gamma # [2843383.854682] gamma data-mesher[213]: time=2026-10-07T05:06:38.277Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> gamma # [2843383.854952] gamma data-mesher[213]: time=2026-10-07T05:06:38.278Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY: [/dns/alpha.clan/tcp/7946]} {12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> gamma # [2843383.854975] gamma data-mesher[213]: time=2026-10-07T05:06:38.278Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> gamma # [2843383.856393] gamma data-mesher[213]: time=2026-10-07T05:06:38.279Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> gamma # [2843383.856467] gamma data-mesher[213]: time=2026-10-07T05:06:38.279Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> gamma # [2843383.858570] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="libp2p host created" peer_id=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA 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 # [2843383.858625] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> gamma # [2843383.858625] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> gamma # [2843383.858625] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> gamma # [2843383.858625] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="starting server"
container-test-run-data-mesher> gamma # [2843383.858678] gamma data-mesher[213]: time=2026-10-07T05:06:38.281Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> gamma # [2843383.858696] gamma data-mesher[213]: time=2026-10-07T05:06:38.282Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> gamma # [2843383.858712] gamma data-mesher[213]: time=2026-10-07T05:06:38.282Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> gamma # [2843383.860827] gamma data-mesher[213]: time=2026-10-07T05:06:38.284Z level=INFO msg="peer connected" peer_id=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-data-mesher> gamma # [2843383.862384] gamma data-mesher[213]: time=2026-10-07T05:06:38.285Z level=INFO msg="peer connected" peer_id=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-data-mesher> gamma # [2843384.012298] gamma systemd-logind[232]: New seat seat0.
container-test-run-data-mesher> gamma # [2843384.012384] gamma systemd[1]: Started User Login Management.
container-test-run-data-mesher> gamma # [2843384.013560] gamma systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> gamma # [2843384.020197] gamma systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> gamma # [2843384.020295] gamma systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> beta # [2843383.832686] beta data-mesher[213]: time=2026-10-07T05:06:38.255Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> beta # [2843383.833037] beta data-mesher[213]: time=2026-10-07T05:06:38.256Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY: [/dns/alpha.clan/tcp/7946]} {12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> beta # [2843383.833037] beta data-mesher[213]: time=2026-10-07T05:06:38.256Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> beta # [2843383.834292] beta data-mesher[213]: time=2026-10-07T05:06:38.257Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> beta # [2843383.834375] beta data-mesher[213]: time=2026-10-07T05:06:38.257Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> beta # [2843383.836780] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="libp2p host created" peer_id=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH 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 # [2843383.836833] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> beta # [2843383.836833] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> beta # [2843383.836833] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> beta # [2843383.836833] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="starting server"
container-test-run-data-mesher> beta # [2843383.836909] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> beta # [2843383.836947] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> beta # [2843383.836971] beta data-mesher[213]: time=2026-10-07T05:06:38.260Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> beta # [2843383.839015] beta data-mesher[213]: time=2026-10-07T05:06:38.262Z level=INFO msg="peer connected" peer_id=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-data-mesher> beta # [2843383.860994] beta data-mesher[213]: time=2026-10-07T05:06:38.284Z level=INFO msg="peer connected" peer_id=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA remote_addr=/ip4/192.168.1.3/tcp/7946
container-test-run-data-mesher> beta # [2843384.004624] beta systemd-logind[232]: New seat seat0.
container-test-run-data-mesher> beta # [2843384.004747] beta systemd[1]: Started User Login Management.
container-test-run-data-mesher> beta # [2843384.013460] beta systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> beta # [2843384.020450] beta systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> beta # [2843384.020525] beta systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> alpha # [2843383.826831] alpha data-mesher[213]: time=2026-10-07T05:06:38.250Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> alpha # [2843383.827153] alpha data-mesher[213]: time=2026-10-07T05:06:38.250Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY: [/dns/alpha.clan/tcp/7946]} {12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> alpha # [2843383.827153] alpha data-mesher[213]: time=2026-10-07T05:06:38.250Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> alpha # [2843383.828457] alpha data-mesher[213]: time=2026-10-07T05:06:38.251Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> alpha # [2843383.828525] alpha data-mesher[213]: time=2026-10-07T05:06:38.251Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> alpha # [2843383.830674] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="libp2p host created" peer_id=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY 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 # [2843383.830708] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> alpha # [2843383.830708] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> alpha # [2843383.830708] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> alpha # [2843383.830708] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="starting server"
container-test-run-data-mesher> alpha # [2843383.830786] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> alpha # [2843383.830811] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> alpha # [2843383.830811] alpha data-mesher[213]: time=2026-10-07T05:06:38.254Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> alpha # [2843383.839243] alpha data-mesher[213]: time=2026-10-07T05:06:38.262Z level=INFO msg="peer connected" peer_id=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-data-mesher> alpha # [2843383.862581] alpha data-mesher[213]: time=2026-10-07T05:06:38.285Z level=INFO msg="peer connected" peer_id=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA remote_addr=/ip4/192.168.1.3/tcp/7946
container-test-run-data-mesher> alpha # [2843384.018708] alpha systemd-logind[232]: New seat seat0.
container-test-run-data-mesher> alpha # [2843384.018818] alpha systemd[1]: Started User Login Management.
container-test-run-data-mesher> alpha # [2843384.019482] alpha systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> alpha # [2843384.025659] alpha systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> alpha # [2843384.025761] alpha systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> gamma # [2843384.384084] gamma systemd-networkd[204]: eth1: Gained IPv6LL
container-test-run-data-mesher> beta # [2843384.448103] beta systemd-networkd[208]: eth1: Gained IPv6LL
container-test-run-data-mesher> alpha # [2843384.576110] 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/16bvq96qda74nr10c3iqk64q9a62sq7b-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/16bvq96qda74nr10c3iqk64q9a62sq7b-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> ??? 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/2dz8bfsj1j9rgxlyrgm856siav96qnip-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/2dz8bfsj1j9rgxlyrgm856siav96qnip-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> gamma # [2843393.833483] gamma data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="received state sync from peer" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843393.833483] gamma data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843393.839347] gamma data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="received state sync from peer" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> gamma # [2843393.839347] gamma data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> gamma # [2843393.858682] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> gamma # [2843393.858682] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843393.858933] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843393.858933] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="state exchange complete" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843393.859020] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="server started"
container-test-run-data-mesher> gamma # [2843393.859020] gamma data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> gamma # [2843393.859102] gamma systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> gamma # [2843393.859271] gamma systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> gamma # [2843393.859369] gamma systemd[1]: Startup finished in 11.767s.
container-test-run-data-mesher> beta # [2843393.839071] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> beta # [2843393.839071] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> beta # [2843393.839456] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> beta # [2843393.839456] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="state exchange complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> beta # [2843393.839456] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="server started"
container-test-run-data-mesher> beta # [2843393.839523] beta data-mesher[213]: time=2026-10-07T05:06:48.262Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> beta # [2843393.839571] beta systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> beta # [2843393.839700] beta systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> beta # [2843393.839796] beta systemd[1]: Startup finished in 11.747s.
container-test-run-data-mesher> alpha # [2843393.833056] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> alpha # [2843393.833056] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843393.833602] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843393.833602] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="state exchange complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843393.833671] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="server started"
container-test-run-data-mesher> alpha # [2843393.833671] alpha data-mesher[213]: time=2026-10-07T05:06:48.256Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> alpha # [2843393.833760] alpha systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> alpha # [2843393.833949] alpha systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> alpha # [2843393.834043] alpha systemd[1]: Startup finished in 11.740s.
container-test-run-data-mesher> alpha # [2843393.858843] alpha data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="received state sync from peer" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843393.858843] alpha data-mesher[213]: time=2026-10-07T05:06:48.282Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843393.987682] alpha data-mesher[213]: time=2026-10-07T05:06:48.411Z 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/16bvq96qda74nr10c3iqk64q9a62sq7b-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/16bvq96qda74nr10c3iqk64q9a62sq7b-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> gamma # [2843398.835177] gamma data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="received state sync from peer" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843398.835177] gamma data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843398.835487] gamma data-mesher[213]: time=2026-10-07T05:06:53.258Z level=DEBUG msg="new file detected" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY name=test_file name=test_file
container-test-run-data-mesher> gamma # [2843398.835487] gamma data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> gamma # [2843398.835487] gamma data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="downloading file" name=test_file signed_at="2026-10-07 05:06:48.409 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843398.837651] gamma data-mesher[213]: time=2026-10-07T05:06:53.260Z level=INFO msg="download complete" name=test_file signed_at="2026-10-07 05:06:48.409 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY written=true elapsed=2.381446ms
container-test-run-data-mesher> gamma # [2843398.859513] gamma data-mesher[213]: time=2026-10-07T05:06:53.282Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [2843398.859545] gamma data-mesher[213]: time=2026-10-07T05:06:53.282Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843398.859796] gamma data-mesher[213]: time=2026-10-07T05:06:53.283Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843398.859815] gamma data-mesher[213]: time=2026-10-07T05:06:53.283Z level=INFO msg="state exchange complete" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843398.859815] gamma data-mesher[213]: time=2026-10-07T05:06:53.283Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [2843398.840080] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [2843398.840311] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> beta # [2843398.840452] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> beta # [2843398.840506] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=DEBUG msg="new file detected" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY name=test_file name=test_file
container-test-run-data-mesher> beta # [2843398.840506] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="state exchange complete" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> beta # [2843398.840506] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> beta # [2843398.840506] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [2843398.840584] beta data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="downloading file" name=test_file signed_at="2026-10-07 05:06:48.409 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> beta # [2843398.841916] beta data-mesher[213]: time=2026-10-07T05:06:53.265Z level=INFO msg="download complete" name=test_file signed_at="2026-10-07 05:06:48.409 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY written=true elapsed=1.410036ms
container-test-run-data-mesher> beta # [2843399.028525] beta data-mesher[213]: time=2026-10-07T05:06:53.451Z level=INFO msg=http_request uri=/files/test_file status=204
container-test-run-data-mesher> alpha # [2843398.834789] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [2843398.834789] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843398.835269] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843398.835269] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="state exchange complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843398.835334] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [2843398.835431] alpha data-mesher[213]: time=2026-10-07T05:06:53.258Z level=INFO msg="received file request" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_file
container-test-run-data-mesher> alpha # [2843398.836289] alpha data-mesher[213]: time=2026-10-07T05:06:53.259Z level=INFO msg="file transfer complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_file
container-test-run-data-mesher> alpha # [2843398.840333] alpha data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="received state sync from peer" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> alpha # [2843398.840333] alpha data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> alpha # [2843398.840646] alpha data-mesher[213]: time=2026-10-07T05:06:53.263Z level=INFO msg="received file request" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_file
container-test-run-data-mesher> alpha # [2843398.841451] alpha data-mesher[213]: time=2026-10-07T05:06:53.264Z level=INFO msg="file transfer complete" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_file
container-test-run-data-mesher> alpha # [2843398.859695] alpha data-mesher[213]: time=2026-10-07T05:06:53.283Z level=INFO msg="received state sync from peer" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843398.859695] alpha data-mesher[213]: time=2026-10-07T05:06:53.283Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.02 seconds)
container-test-run-data-mesher> beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds)
container-test-run-data-mesher> gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file
container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.00 seconds)
container-test-run-data-mesher> alpha: must succeed: cat /nix/store/4ajyxdqzwzll8abdpcn7244kal1rlznz-per-machine-alpha-data-mesher-node-identity_identity.pub
container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/4ajyxdqzwzll8abdpcn7244kal1rlznz-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/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/16bvq96qda74nr10c3iqk64q9a62sq7b-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/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/16bvq96qda74nr10c3iqk64q9a62sq7b-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/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M, in 0.00 seconds)
container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma # [2843403.860229] gamma data-mesher[213]: time=2026-10-07T05:06:58.283Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [2843403.860229] gamma data-mesher[213]: time=2026-10-07T05:06:58.283Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843403.860632] gamma data-mesher[213]: time=2026-10-07T05:06:58.283Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843403.860935] gamma data-mesher[213]: time=2026-10-07T05:06:58.284Z level=DEBUG msg="imported tombstone" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY name=test_file written=true
container-test-run-data-mesher> gamma # [2843403.860935] gamma data-mesher[213]: time=2026-10-07T05:06:58.284Z level=INFO msg="state exchange complete" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> gamma # [2843403.861026] gamma data-mesher[213]: time=2026-10-07T05:06:58.284Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [2843403.836409] beta data-mesher[213]: time=2026-10-07T05:06:58.259Z level=INFO msg="received state sync from peer" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> beta # [2843403.836409] beta data-mesher[213]: time=2026-10-07T05:06:58.259Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> beta # [2843403.841257] beta data-mesher[213]: time=2026-10-07T05:06:58.264Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [2843403.841311] beta data-mesher[213]: time=2026-10-07T05:06:58.264Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> beta # [2843403.841480] beta data-mesher[213]: time=2026-10-07T05:06:58.264Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> beta # [2843403.841501] beta data-mesher[213]: time=2026-10-07T05:06:58.264Z level=INFO msg="state exchange complete" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY timeout=5s
container-test-run-data-mesher> beta # [2843403.841501] beta data-mesher[213]: time=2026-10-07T05:06:58.264Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [2843403.836053] alpha data-mesher[213]: time=2026-10-07T05:06:58.259Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [2843403.836332] alpha data-mesher[213]: time=2026-10-07T05:06:58.259Z level=DEBUG msg="initiating state exchange" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH timeout=5s
container-test-run-data-mesher> alpha # [2843403.836506] alpha data-mesher[213]: time=2026-10-07T05:06:58.259Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> alpha # [2843403.837015] alpha data-mesher[213]: time=2026-10-07T05:06:58.260Z level=DEBUG msg="imported tombstone" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH name=test_file written=true
container-test-run-data-mesher> alpha # [2843403.837015] alpha data-mesher[213]: time=2026-10-07T05:06:58.260Z level=INFO msg="state exchange complete" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH timeout=5s
container-test-run-data-mesher> alpha # [2843403.837047] alpha data-mesher[213]: time=2026-10-07T05:06:58.260Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [2843403.841414] alpha data-mesher[213]: time=2026-10-07T05:06:58.264Z level=INFO msg="received state sync from peer" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> alpha # [2843403.841414] alpha data-mesher[213]: time=2026-10-07T05:06:58.264Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> alpha # [2843403.860395] alpha data-mesher[213]: time=2026-10-07T05:06:58.283Z level=INFO msg="received state sync from peer" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843403.860395] alpha data-mesher[213]: time=2026-10-07T05:06:58.283Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843404.070691] alpha data-mesher[213]: time=2026-10-07T05:06:58.494Z level=INFO msg=http_request uri=/files/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M status=204
container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M, in 5.02 seconds)
container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M, 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/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/16bvq96qda74nr10c3iqk64q9a62sq7b-shared-data-mesher-network_network.pub
container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer CpMO4m6kNcIjoOgAQqL/kfXzuMPVyphCKFIYiTTTC0M= is not authorized for this file test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> alpha # [2843408.837192] alpha data-mesher[213]: time=2026-10-07T05:07:03.260Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [2843408.837473] alpha data-mesher[213]: time=2026-10-07T05:07:03.260Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843408.837746] alpha data-mesher[213]: time=2026-10-07T05:07:03.261Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> alpha # [2843408.837746] alpha data-mesher[213]: time=2026-10-07T05:07:03.261Z level=INFO msg="state exchange complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> alpha # [2843408.837821] alpha data-mesher[213]: time=2026-10-07T05:07:03.261Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [2843408.838349] alpha data-mesher[213]: time=2026-10-07T05:07:03.261Z level=INFO msg="received file request" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> alpha # [2843408.839018] alpha data-mesher[213]: time=2026-10-07T05:07:03.262Z level=INFO msg="file transfer complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> alpha # [2843409.114275] alpha data-mesher[213]: time=2026-10-07T05:07:03.537Z level=INFO msg=http_request uri=/files/test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M status=403
container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/16bvq96qda74nr10c3iqk64q9a62sq7b-shared-data-mesher-network_network.pub, in 0.01 seconds)
container-test-run-data-mesher> (finished: run the VM test script, in 27.30 seconds)
container-test-run-data-mesher> gamma # [2843408.837550] gamma data-mesher[213]: time=2026-10-07T05:07:03.260Z level=INFO msg="received state sync from peer" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843408.837550] gamma data-mesher[213]: time=2026-10-07T05:07:03.260Z level=INFO msg="merging remote state" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843408.837799] gamma data-mesher[213]: time=2026-10-07T05:07:03.260Z level=DEBUG msg="new file detected" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY name=test_file name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma # [2843408.837799] gamma data-mesher[213]: time=2026-10-07T05:07:03.261Z level=INFO msg="scheduling file download" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma # [2843408.838014] gamma data-mesher[213]: time=2026-10-07T05:07:03.261Z level=INFO msg="downloading file" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M signed_at="2026-10-07 05:06:58.493 +0000 UTC" signed_by="CpMO4m6kNcIjoOgAQqL/kfXzuMPVyphCKFIYiTTTC0M=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY
container-test-run-data-mesher> gamma # [2843408.839340] gamma data-mesher[213]: time=2026-10-07T05:07:03.262Z level=INFO msg="download complete" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M signed_at="2026-10-07 05:06:58.493 +0000 UTC" signed_by="CpMO4m6kNcIjoOgAQqL/kfXzuMPVyphCKFIYiTTTC0M=" peer=12D3KooWAXeJdSy2LDFW3FczXRGBUG7kSmhEM2iYq21LzqSJwWRY written=true elapsed=1.572982ms
container-test-run-data-mesher> gamma # [2843408.842267] gamma data-mesher[213]: time=2026-10-07T05:07:03.265Z level=INFO msg="received state sync from peer" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> gamma # [2843408.842267] gamma data-mesher[213]: time=2026-10-07T05:07:03.265Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> gamma # [2843408.843227] gamma data-mesher[213]: time=2026-10-07T05:07:03.266Z level=INFO msg="received file request" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma # [2843408.843982] gamma data-mesher[213]: time=2026-10-07T05:07:03.267Z level=INFO msg="file transfer complete" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH network="/wjPmajxADvadlkCatauJK+hIhWinwwW9AiJpDrtfnk=" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> gamma # [2843408.861435] gamma data-mesher[213]: time=2026-10-07T05:07:03.284Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [2843408.861435] gamma data-mesher[213]: time=2026-10-07T05:07:03.284Z level=DEBUG msg="initiating state exchange" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH timeout=5s
container-test-run-data-mesher> gamma # [2843408.861811] gamma data-mesher[213]: time=2026-10-07T05:07:03.285Z level=INFO msg="merging remote state" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH
container-test-run-data-mesher> gamma # [2843408.861878] gamma data-mesher[213]: time=2026-10-07T05:07:03.285Z level=INFO msg="state exchange complete" peer=12D3KooWS2RgGRKztKAR2xbF6h5UP2QFoSVuAHVj8Q993zhuMfTH timeout=5s
container-test-run-data-mesher> gamma # [2843408.861907] gamma data-mesher[213]: time=2026-10-07T05:07:03.285Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [2843408.842107] beta data-mesher[213]: time=2026-10-07T05:07:03.265Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [2843408.842107] beta data-mesher[213]: time=2026-10-07T05:07:03.265Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> beta # [2843408.842396] beta data-mesher[213]: time=2026-10-07T05:07:03.265Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> beta # [2843408.842700] beta data-mesher[213]: time=2026-10-07T05:07:03.266Z level=DEBUG msg="new file detected" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA name=test_file name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> beta # [2843408.842724] beta data-mesher[213]: time=2026-10-07T05:07:03.266Z level=INFO msg="state exchange complete" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA timeout=5s
container-test-run-data-mesher> beta # [2843408.842763] beta data-mesher[213]: time=2026-10-07T05:07:03.266Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [2843408.842782] beta data-mesher[213]: time=2026-10-07T05:07:03.266Z level=INFO msg="scheduling file download" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M
container-test-run-data-mesher> beta # [2843408.842966] beta data-mesher[213]: time=2026-10-07T05:07:03.266Z level=INFO msg="downloading file" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M signed_at="2026-10-07 05:06:58.493 +0000 UTC" signed_by="CpMO4m6kNcIjoOgAQqL/kfXzuMPVyphCKFIYiTTTC0M=" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> beta # [2843408.844326] beta data-mesher[213]: time=2026-10-07T05:07:03.267Z level=INFO msg="download complete" name=test_ns/CpMO4m6kNcIjoOgAQqL_kfXzuMPVyphCKFIYiTTTC0M signed_at="2026-10-07 05:06:58.493 +0000 UTC" signed_by="CpMO4m6kNcIjoOgAQqL/kfXzuMPVyphCKFIYiTTTC0M=" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA written=true elapsed=1.52897ms
container-test-run-data-mesher> beta # [2843408.861627] beta data-mesher[213]: time=2026-10-07T05:07:03.284Z level=INFO msg="received state sync from peer" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> beta # [2843408.861627] beta data-mesher[213]: time=2026-10-07T05:07:03.284Z level=INFO msg="merging remote state" peer=12D3KooWMLQhYy44WLQnruemC3J7MsZqT36isUiNgEKork32aoPA
container-test-run-data-mesher> test script finished in 28.37s
container-test-run-data-mesher> cleanup
container-test-run-data-mesher> kill NspawnMachine (pid 53)
container-test-run-data-mesher> kill NspawnMachine (pid 54)
container-test-run-data-mesher> Container alpha terminated by signal KILL.
container-test-run-data-mesher> kill NspawnMachine (pid 55)
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)