these 15 derivations will be built:
  /nix/store/jricp91gwrlaxbsckf9vmrnc6lq7k5l6-etc.drv
  /nix/store/kl7qrhhgph1iymfcnsngk8i1ajlhiln1-activate.drv
  /nix/store/3gsi2xlnq7cs4x43s21d18zzkjbncbal-nixos-system-beta-test.drv
  /nix/store/6j31r7ibgg1ppzh5h6zixz9n61svfri9-etc.drv
  /nix/store/yngrbqmzb7835jxczysgff6mvavxipa2-activate.drv
  /nix/store/3jykkz4sy2c81z8zqbplnmw1psmpqgng-nixos-system-gamma-test.drv
  /nix/store/5njh8d196rl3y81kyzcni2h38fnpbn47-run-gamma-nspawn.drv
  /nix/store/qb0mslqbplkfg3r0g2wfxbrhnijv047g-etc.drv
  /nix/store/vwplcq0vxfclvj19r651kd8y3jm0fzrc-activate.drv
  /nix/store/pl80x0kjikj4qajisdwyh07vyj77nlan-nixos-system-alpha-test.drv
  /nix/store/79pzh3h4pz6dx5cgdn964k8a18kj2c0a-run-alpha-nspawn.drv
  /nix/store/d93f1y5hmdw496ly5ff1dw9g29vi07mz-run-beta-nspawn.drv
  /nix/store/ldi4msw1psfvbvyh8yw7hfhxm53z3d2s-driverConfiguration.json.drv
  /nix/store/7b9pzc2lnqgynn42s5v31qwnh7zv13wa-nixos-test-driver-data-mesher.drv
  /nix/store/m0k50jzhnnqylggq758ak4b28bgf3xvn-container-test-run-data-mesher.drv
building '/nix/store/6j31r7ibgg1ppzh5h6zixz9n61svfri9-etc.drv'
building '/nix/store/jricp91gwrlaxbsckf9vmrnc6lq7k5l6-etc.drv'
building '/nix/store/qb0mslqbplkfg3r0g2wfxbrhnijv047g-etc.drv'
building '/nix/store/yngrbqmzb7835jxczysgff6mvavxipa2-activate.drv'
building '/nix/store/kl7qrhhgph1iymfcnsngk8i1ajlhiln1-activate.drv'
building '/nix/store/vwplcq0vxfclvj19r651kd8y3jm0fzrc-activate.drv'
activate> structuredAttrs is enabled
activate> structuredAttrs is enabled
building '/nix/store/3gsi2xlnq7cs4x43s21d18zzkjbncbal-nixos-system-beta-test.drv'
building '/nix/store/3jykkz4sy2c81z8zqbplnmw1psmpqgng-nixos-system-gamma-test.drv'
activate> structuredAttrs is enabled
nixos-system-beta-test> structuredAttrs is enabled
building '/nix/store/pl80x0kjikj4qajisdwyh07vyj77nlan-nixos-system-alpha-test.drv'
nixos-system-gamma-test> structuredAttrs is enabled
building '/nix/store/d93f1y5hmdw496ly5ff1dw9g29vi07mz-run-beta-nspawn.drv'
nixos-system-alpha-test> structuredAttrs is enabled
building '/nix/store/5njh8d196rl3y81kyzcni2h38fnpbn47-run-gamma-nspawn.drv'
building '/nix/store/79pzh3h4pz6dx5cgdn964k8a18kj2c0a-run-alpha-nspawn.drv'
building '/nix/store/ldi4msw1psfvbvyh8yw7hfhxm53z3d2s-driverConfiguration.json.drv'
driverConfiguration.json> structuredAttrs is enabled
building '/nix/store/7b9pzc2lnqgynn42s5v31qwnh7zv13wa-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/m0k50jzhnnqylggq758ak4b28bgf3xvn-container-test-run-data-mesher.drv' on 'ssh-ng://builder@build-x86-01.clan.lol'
building '/nix/store/m0k50jzhnnqylggq758ak4b28bgf3xvn-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.01 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> alpha: Waiting for journal at /build/vm-state-alpha/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> gamma: systemd-nspawn running (pid 55)
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(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> 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> 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 beta on /build/vm-state-beta.
container-test-run-data-mesher> ░ Spawning container alpha on /build/vm-state-alpha.
container-test-run-data-mesher> alpha # Journal file /build/vm-state-alpha/var/log/journal/ffcfc56c1e7241e89051b0e360d87e03/system.journal is truncated, ignoring file.
container-test-run-data-mesher> alpha # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> gamma # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> beta # No journal boot entry found for the specified boot (+0).
container-test-run-data-mesher> beta # [1583221.842314] beta systemd-journald[90]: Journal started
container-test-run-data-mesher> beta # [1583221.842353] beta systemd-journald[90]: Runtime Journal (/run/log/journal/f8273a091d1344838df907c3592007b0) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> beta # [1583221.885177] beta systemd[1]: Listening on Journal Log Access Socket.
container-test-run-data-mesher> beta # [1583221.886070] beta systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> beta # [1583221.898937] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> beta # [1583221.914089] beta systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> beta # [1583221.914675] beta systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> beta # [1583221.915089] beta systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> beta # [1583221.919195] beta systemd-journald[90]: Time spent on flushing to /var/log/journal/f8273a091d1344838df907c3592007b0 is 1.332ms for 8 entries.
container-test-run-data-mesher> beta # [1583221.919195] beta systemd-journald[90]: System Journal (/var/log/journal/f8273a091d1344838df907c3592007b0) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> beta # [1583221.931205] beta systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> beta # [1583221.931686] beta systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> beta # [1583221.931752] beta systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> beta # [1583221.932256] beta systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> beta # [1583221.932289] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [1583221.932754] beta systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> alpha # [1583221.870195] alpha systemd-journald[90]: Journal started
container-test-run-data-mesher> beta # [1583221.932772] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> alpha # [1583221.870241] alpha systemd-journald[90]: Runtime Journal (/run/log/journal/ffcfc56c1e7241e89051b0e360d87e03) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> beta # [1583221.960202] beta systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [1583221.821609] gamma systemd-journald[90]: Journal started
container-test-run-data-mesher> beta # [1583221.960273] beta systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> alpha # [1583221.889138] alpha systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> beta # [1583221.960421] beta systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> alpha # [1583221.902234] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> gamma # [1583221.821651] gamma systemd-journald[90]: Runtime Journal (/run/log/journal/80eba70a7293479085a8f894800d29fd) is 8M, max 3.7G, 3.7G free.
container-test-run-data-mesher> alpha # [1583221.920738] alpha systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> gamma # [1583221.831071] gamma systemd[1]: Finished Apply Kernel Variables.
container-test-run-data-mesher> alpha # [1583221.921142] alpha systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> gamma # [1583221.871647] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
container-test-run-data-mesher> alpha # [1583221.921452] alpha systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> gamma # [1583221.885032] gamma systemd[1]: Starting Flush Journal to Persistent Storage...
container-test-run-data-mesher> alpha # [1583221.925218] alpha systemd-journald[90]: Time spent on flushing to /var/log/journal/ffcfc56c1e7241e89051b0e360d87e03 is 1.127ms for 7 entries.
container-test-run-data-mesher> gamma # [1583221.885663] gamma systemd[1]: Starting Network Name Resolution...
container-test-run-data-mesher> alpha # [1583221.925218] alpha systemd-journald[90]: System Journal (/var/log/journal/ffcfc56c1e7241e89051b0e360d87e03) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> gamma # [1583221.886142] gamma systemd[1]: Starting Create Static Device Nodes in /dev...
container-test-run-data-mesher> alpha # [1583221.939891] alpha systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> beta # [1583221.960958] beta systemd[1]: Starting Network Management...
container-test-run-data-mesher> alpha # [1583221.940621] alpha systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> gamma # [1583221.906428] gamma systemd-journald[90]: Time spent on flushing to /var/log/journal/80eba70a7293479085a8f894800d29fd is 1.126ms for 7 entries.
container-test-run-data-mesher> alpha # [1583221.940709] alpha systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> gamma # [1583221.906428] gamma systemd-journald[90]: System Journal (/var/log/journal/80eba70a7293479085a8f894800d29fd) is 8M, max 4G, 3.9G free.
container-test-run-data-mesher> alpha # [1583221.941354] alpha systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> gamma # [1583221.921978] gamma systemd[1]: Finished Create Static Device Nodes in /dev.
container-test-run-data-mesher> alpha # [1583221.941391] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [1583221.922508] gamma systemd[1]: Reached target Preparation for Local File Systems.
container-test-run-data-mesher> alpha # [1583221.941958] alpha systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> gamma # [1583221.922572] gamma systemd[1]: Reached target Local File Systems.
container-test-run-data-mesher> alpha # [1583221.941982] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> gamma # [1583221.923091] gamma systemd[1]: Listening on Boot Loader Control Service Socket.
container-test-run-data-mesher> alpha # [1583222.100914] alpha systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [1583221.923125] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [1583221.923595] gamma systemd[1]: Starting Save Transient machine-id to Disk...
container-test-run-data-mesher> gamma # [1583221.923613] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys
container-test-run-data-mesher> gamma # [1583221.942639] gamma systemd[1]: Finished Firewall.
container-test-run-data-mesher> gamma # [1583221.942710] gamma systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> gamma # [1583221.942857] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> gamma # [1583221.943424] gamma systemd[1]: Starting Network Management...
container-test-run-data-mesher> gamma # [1583222.047451] gamma systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> gamma # [1583222.048310] gamma systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> gamma # [1583222.061130] gamma systemd-tmpfiles[201]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.061331] gamma systemd-tmpfiles[201]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.061473] gamma systemd-tmpfiles[201]: fchmod() of /var/log/journal/80eba70a7293479085a8f894800d29fd failed: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.061686] gamma systemd-tmpfiles[201]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.067353] gamma systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> gamma # [1583222.068827] gamma systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> gamma # [1583222.069422] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> gamma # [1583222.096407] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> gamma # [1583222.099935] gamma systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> gamma # [1583222.100710] gamma systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> gamma # [1583222.109384] gamma systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> gamma # [1583222.783784] gamma systemd-networkd[197]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.783864] gamma systemd-networkd[197]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> gamma # [1583222.791964] gamma systemd-networkd[197]: /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 # [1583222.792119] gamma systemd-networkd[197]: /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 # [1583222.792213] gamma systemd-networkd[197]: lo: Link UP
container-test-run-data-mesher> gamma # [1583222.792217] gamma systemd-networkd[197]: lo: Gained carrier
container-test-run-data-mesher> gamma # [1583222.792381] gamma systemd-networkd[197]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> gamma # [1583222.792663] gamma systemd[1]: Started Network Management.
container-test-run-data-mesher> gamma # [1583222.792718] gamma systemd-networkd[197]: eth1: Link UP
container-test-run-data-mesher> gamma # [1583222.792886] gamma systemd-networkd[197]: eth1: Gained carrier
container-test-run-data-mesher> gamma # [1583222.793423] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> gamma # [1583223.035668] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> beta # [1583222.152391] beta systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> beta # [1583222.156079] beta systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> beta # [1583222.167986] beta systemd-tmpfiles[201]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [1583222.168193] beta systemd-tmpfiles[201]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [1583222.168334] beta systemd-tmpfiles[201]: fchmod() of /var/log/journal/f8273a091d1344838df907c3592007b0 failed: Operation not permitted
container-test-run-data-mesher> beta # [1583222.168544] beta systemd-tmpfiles[201]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> beta # [1583222.169952] beta systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> beta # [1583222.170764] beta systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> beta # [1583222.171288] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> beta # [1583222.198796] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> beta # [1583222.205869] beta systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> beta # [1583222.206821] beta systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> beta # [1583222.215592] beta systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> beta # [1583222.799263] beta systemd-networkd[197]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [1583222.799339] beta systemd-networkd[197]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> beta # [1583222.806610] beta systemd-networkd[197]: /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 # [1583222.806758] beta systemd-networkd[197]: /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 # [1583222.806825] beta systemd-networkd[197]: lo: Link UP
container-test-run-data-mesher> beta # [1583222.806828] beta systemd-networkd[197]: lo: Gained carrier
container-test-run-data-mesher> beta # [1583222.806958] beta systemd-networkd[197]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> beta # [1583222.807207] beta systemd[1]: Started Network Management.
container-test-run-data-mesher> beta # [1583222.812151] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> beta # [1583222.812155] beta systemd-networkd[197]: eth1: Link UP
container-test-run-data-mesher> beta # [1583222.812365] beta systemd-networkd[197]: eth1: Gained carrier
container-test-run-data-mesher> beta # [1583223.036056] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> alpha # [1583222.101583] alpha systemd[1]: Reached target Preparation for Network.
container-test-run-data-mesher> alpha # [1583222.101852] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.
container-test-run-data-mesher> alpha # [1583222.102855] alpha systemd[1]: Starting Network Management...
container-test-run-data-mesher> alpha # [1583222.109778] alpha systemd[1]: Finished Flush Journal to Persistent Storage.
container-test-run-data-mesher> alpha # [1583222.110478] alpha systemd[1]: Starting Create System Files and Directories...
container-test-run-data-mesher> alpha # [1583222.123645] alpha systemd-tmpfiles[201]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.123843] alpha systemd-tmpfiles[201]: fchmod() of /var/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.123977] alpha systemd-tmpfiles[201]: fchmod() of /var/log/journal/ffcfc56c1e7241e89051b0e360d87e03 failed: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.124311] alpha systemd-tmpfiles[201]: fchmod() of /run/log/journal failed: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.125744] alpha systemd[1]: Finished Create System Files and Directories.
container-test-run-data-mesher> alpha # [1583222.126522] alpha systemd[1]: Starting Rebuild Journal Catalog...
container-test-run-data-mesher> alpha # [1583222.127053] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...
container-test-run-data-mesher> alpha # [1583222.137242] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.
container-test-run-data-mesher> alpha # [1583222.145138] alpha systemd[1]: Finished Rebuild Journal Catalog.
container-test-run-data-mesher> alpha # [1583222.145934] alpha systemd[1]: Starting Update is Completed...
container-test-run-data-mesher> alpha # [1583222.157094] alpha systemd[1]: Finished Update is Completed.
container-test-run-data-mesher> alpha # [1583222.882873] alpha systemd-networkd[198]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.882959] alpha systemd-networkd[198]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted
container-test-run-data-mesher> alpha # [1583222.890744] alpha systemd-networkd[198]: /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 # [1583222.890898] alpha systemd-networkd[198]: /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 # [1583222.891009] alpha systemd-networkd[198]: lo: Link UP
container-test-run-data-mesher> alpha # [1583222.891015] alpha systemd-networkd[198]: lo: Gained carrier
container-test-run-data-mesher> alpha # [1583222.891159] alpha systemd-networkd[198]: eth1: Configuring with /etc/systemd/network/40-eth1.network.
container-test-run-data-mesher> alpha # [1583222.891468] alpha systemd[1]: Started Network Management.
container-test-run-data-mesher> alpha # [1583222.891515] alpha systemd-networkd[198]: eth1: Link UP
container-test-run-data-mesher> alpha # [1583222.891658] alpha systemd-networkd[198]: eth1: Gained carrier
container-test-run-data-mesher> alpha # [1583222.892733] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...
container-test-run-data-mesher> alpha # [1583223.034496] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.
container-test-run-data-mesher> gamma # [1583223.208275] gamma systemd-resolved[146]: Positive Trust Anchors:
container-test-run-data-mesher> gamma # [1583223.208285] gamma systemd-resolved[146]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> gamma # [1583223.208288] gamma systemd-resolved[146]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> gamma # [1583223.208310] gamma systemd-resolved[146]: 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 # [1583223.219219] gamma systemd-resolved[146]: Using system hostname 'gamma'.
container-test-run-data-mesher> gamma # [1583223.220176] gamma systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> gamma # [1583223.220243] gamma systemd[1]: Reached target Network.
container-test-run-data-mesher> gamma # [1583223.220291] gamma systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> gamma # [1583223.220333] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> gamma # [1583223.220353] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> gamma # [1583223.220364] gamma systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> gamma # [1583223.220465] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> gamma # [1583223.220544] gamma systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> gamma # [1583223.220641] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> gamma # [1583223.220656] gamma systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> gamma # [1583223.220683] gamma systemd[1]: Reached target Basic System.
container-test-run-data-mesher> gamma # [1583223.221648] gamma systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> gamma # [1583223.222073] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> gamma # [1583223.222575] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> gamma # [1583223.223371] gamma systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> gamma # [1583223.258652] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> beta # [1583223.277079] beta systemd-resolved[149]: Positive Trust Anchors:
container-test-run-data-mesher> beta # [1583223.277087] beta systemd-resolved[149]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> beta # [1583223.277092] beta systemd-resolved[149]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> beta # [1583223.277116] beta systemd-resolved[149]: 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 # [1583223.290189] beta systemd-resolved[149]: Using system hostname 'beta'.
container-test-run-data-mesher> beta # [1583223.291076] beta systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> beta # [1583223.291149] beta systemd[1]: Reached target Network.
container-test-run-data-mesher> beta # [1583223.291200] beta systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> beta # [1583223.291247] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> beta # [1583223.291269] beta systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> beta # [1583223.291283] beta systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> beta # [1583223.291389] beta systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> beta # [1583223.291476] beta systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> beta # [1583223.291577] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> beta # [1583223.291596] beta systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> beta # [1583223.291629] beta systemd[1]: Reached target Basic System.
container-test-run-data-mesher> beta # [1583223.293475] beta systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> beta # [1583223.293936] beta systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> beta # [1583223.294434] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> beta # [1583223.295161] beta systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> beta # [1583223.304744] beta systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> beta # [1583223.500769] beta nsncd[214]: Sep 22 15:03:57.924 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> beta # [1583223.500821] beta systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> beta # [1583223.500953] beta systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> beta # [1583223.501037] beta systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> beta # [1583223.501883] beta systemd[1]: Starting User Login Management...
container-test-run-data-mesher> beta # [1583223.502432] beta systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> beta # [1583223.536171] beta systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> beta # [1583223.538288] beta systemd[1]: Started Console Getty.
container-test-run-data-mesher> gamma # [1583223.451688] gamma nsncd[214]: Sep 22 15:03:57.874 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> beta # [1583223.538315] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> gamma # [1583223.451668] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> beta # [1583223.538329] beta systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> gamma # [1583223.451717] gamma systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> beta # [1583223.630622] beta dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> gamma # [1583223.451756] gamma systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> beta # [1583223.797882] beta dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> gamma # [1583223.452656] gamma systemd[1]: Starting User Login Management...
container-test-run-data-mesher> beta # [1583223.797882] beta dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> gamma # [1583223.453078] gamma systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> beta # [1583223.631548] beta systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> gamma # [1583223.461657] gamma systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> alpha # [1583223.275580] alpha systemd-resolved[143]: Positive Trust Anchors:
container-test-run-data-mesher> gamma # [1583223.462535] gamma systemd[1]: Started Console Getty.
container-test-run-data-mesher> alpha # [1583223.275591] alpha systemd-resolved[143]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
container-test-run-data-mesher> gamma # [1583223.462572] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> alpha # [1583223.275594] alpha systemd-resolved[143]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16
container-test-run-data-mesher> gamma # [1583223.462586] gamma systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> gamma # [1583223.603279] gamma dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> alpha # [1583223.275612] alpha systemd-resolved[143]: 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 # [1583223.797900] gamma dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> alpha # [1583223.287874] alpha systemd-resolved[143]: Using system hostname 'alpha'.
container-test-run-data-mesher> alpha # [1583223.288954] alpha systemd[1]: Started Network Name Resolution.
container-test-run-data-mesher> gamma # [1583223.797900] gamma dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> alpha # [1583223.289049] alpha systemd[1]: Reached target Network.
container-test-run-data-mesher> gamma # [1583223.604186] gamma systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> alpha # [1583223.289096] alpha systemd[1]: Reached target System Initialization.
container-test-run-data-mesher> alpha # [1583223.289134] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container
container-test-run-data-mesher> alpha # [1583223.289154] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.
container-test-run-data-mesher> alpha # [1583223.289168] alpha systemd[1]: Reached target Timer Units.
container-test-run-data-mesher> alpha # [1583223.289274] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.
container-test-run-data-mesher> alpha # [1583223.289357] alpha systemd[1]: Listening on Nix Daemon Socket.
container-test-run-data-mesher> alpha # [1583223.289446] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.
container-test-run-data-mesher> alpha # [1583223.289458] alpha systemd[1]: Reached target Socket Units.
container-test-run-data-mesher> alpha # [1583223.289488] alpha systemd[1]: Reached target Basic System.
container-test-run-data-mesher> alpha # [1583223.290403] alpha systemd[1]: Starting data mesher daemon...
container-test-run-data-mesher> alpha # [1583223.290970] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...
container-test-run-data-mesher> alpha # [1583223.291614] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...
container-test-run-data-mesher> alpha # [1583223.292448] alpha systemd[1]: Starting D-Bus System Message Bus...
container-test-run-data-mesher> alpha # [1583223.304398] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.
container-test-run-data-mesher> alpha # [1583223.462415] alpha nsncd[214]: Sep 22 15:03:57.885 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
container-test-run-data-mesher> alpha # [1583223.462451] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).
container-test-run-data-mesher> alpha # [1583223.462495] alpha systemd[1]: Reached target Host and Network Name Lookups.
container-test-run-data-mesher> alpha # [1583223.462529] alpha systemd[1]: Reached target User and Group Name Lookups.
container-test-run-data-mesher> alpha # [1583223.463183] alpha systemd[1]: Starting User Login Management...
container-test-run-data-mesher> alpha # [1583223.463682] alpha systemd[1]: Starting Permit User Sessions...
container-test-run-data-mesher> alpha # [1583223.471257] alpha systemd[1]: Finished Permit User Sessions.
container-test-run-data-mesher> alpha # [1583223.471855] alpha systemd[1]: Started Console Getty.
container-test-run-data-mesher> alpha # [1583223.471883] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0
container-test-run-data-mesher> alpha # [1583223.471896] alpha systemd[1]: Reached target Login Prompts.
container-test-run-data-mesher> alpha # [1583223.797797] alpha dbus-broker-launch[215]: Looking up NSS user entry for 'systemd-timesync'...
container-test-run-data-mesher> alpha # [1583223.797797] alpha dbus-broker-launch[215]: NSS returned no entry for 'systemd-timesync'
container-test-run-data-mesher> alpha # [1583223.797797] alpha dbus-broker-launch[215]: Invalid user-name in /nix/store/pzm8nnfsn4xh0lajvw40idv8y3jlsd1l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
container-test-run-data-mesher> alpha # [1583223.620548] alpha systemd[1]: Started D-Bus System Message Bus.
container-test-run-data-mesher> alpha # [1583223.623980] alpha dbus-broker-launch[215]: Ready
container-test-run-data-mesher> gamma # [1583223.607693] gamma dbus-broker-launch[215]: Ready
container-test-run-data-mesher> gamma # [1583224.003557] gamma data-mesher[212]: time=2026-09-22T15:03:58.426Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> gamma # [1583224.003973] gamma data-mesher[212]: time=2026-09-22T15:03:58.427Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> gamma # [1583224.004008] gamma data-mesher[212]: time=2026-09-22T15:03:58.427Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> alpha # [1583224.028484] alpha data-mesher[212]: time=2026-09-22T15:03:58.451Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> alpha # [1583224.029797] alpha data-mesher[212]: time=2026-09-22T15:03:58.453Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> alpha # [1583224.029797] alpha data-mesher[212]: time=2026-09-22T15:03:58.453Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> beta # [1583223.635089] beta dbus-broker-launch[215]: Ready
container-test-run-data-mesher> beta # [1583224.000099] beta systemd-networkd[197]: eth1: Gained IPv6LL
container-test-run-data-mesher> beta # [1583224.028510] beta data-mesher[212]: time=2026-09-22T15:03:58.451Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]
container-test-run-data-mesher> beta # [1583224.028960] beta data-mesher[212]: time=2026-09-22T15:03:58.452Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD: [/dns/alpha.clan/tcp/7946]} {12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> beta # [1583224.028986] beta data-mesher[212]: time=2026-09-22T15:03:58.452Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml
container-test-run-data-mesher> beta # [1583224.158810] beta data-mesher[212]: time=2026-09-22T15:03:58.582Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> beta # [1583224.158879] beta data-mesher[212]: time=2026-09-22T15:03:58.582Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> alpha # [1583224.149878] alpha systemd-logind[231]: New seat seat0.
container-test-run-data-mesher> alpha # [1583224.149974] alpha systemd[1]: Started User Login Management.
container-test-run-data-mesher> alpha # [1583224.152865] alpha systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> alpha # [1583224.158778] alpha data-mesher[212]: time=2026-09-22T15:03:58.582Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> alpha # [1583224.158912] alpha data-mesher[212]: time=2026-09-22T15:03:58.582Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> alpha # [1583224.161969] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="libp2p host created" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD 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 # [1583224.162012] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> alpha # [1583224.162012] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> alpha # [1583224.162012] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> alpha # [1583224.162055] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="starting server"
container-test-run-data-mesher> alpha # [1583224.162123] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> alpha # [1583224.162138] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> alpha # [1583224.162162] alpha data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> alpha # [1583224.168340] alpha data-mesher[212]: time=2026-09-22T15:03:58.591Z level=INFO msg="peer connected" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE remote_addr=/ip4/192.168.1.3/tcp/7946
container-test-run-data-mesher> alpha # [1583224.176716] alpha systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> alpha # [1583224.176867] alpha systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> beta # [1583224.162644] beta data-mesher[212]: time=2026-09-22T15:03:58.585Z level=INFO msg="libp2p host created" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V 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 # [1583224.162726] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> beta # [1583224.162726] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> beta # [1583224.162726] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> beta # [1583224.162726] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="starting server"
container-test-run-data-mesher> beta # [1583224.162838] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> beta # [1583224.162838] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> beta # [1583224.162883] beta data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> beta # [1583224.166348] beta data-mesher[212]: time=2026-09-22T15:03:58.589Z level=INFO msg="peer connected" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE remote_addr=/ip4/192.168.1.3/tcp/7946
container-test-run-data-mesher> beta # [1583224.218366] beta systemd-logind[231]: New seat seat0.
container-test-run-data-mesher> beta # [1583224.218471] beta systemd[1]: Started User Login Management.
container-test-run-data-mesher> beta # [1583224.219172] beta systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> beta # [1583224.253120] beta systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> beta # [1583224.253224] beta systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> gamma # [1583224.129097] gamma systemd-networkd[197]: eth1: Gained IPv6LL
container-test-run-data-mesher> gamma # [1583224.159664] gamma data-mesher[212]: time=2026-09-22T15:03:58.582Z level=INFO msg="checking file integrity"
container-test-run-data-mesher> gamma # [1583224.159761] gamma data-mesher[212]: time=2026-09-22T15:03:58.583Z level=INFO msg="file integrity check complete"
container-test-run-data-mesher> gamma # [1583224.162807] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="libp2p host created" peer_id=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE 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 # [1583224.162864] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=GET path=/files
container-test-run-data-mesher> gamma # [1583224.162864] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name
container-test-run-data-mesher> gamma # [1583224.162864] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name
container-test-run-data-mesher> gamma # [1583224.162864] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="starting server"
container-test-run-data-mesher> gamma # [1583224.162970] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="waiting for DHT to populate" delay=10s
container-test-run-data-mesher> gamma # [1583224.162970] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="HTTP server listening" address=[::1]:7331
container-test-run-data-mesher> gamma # [1583224.162970] gamma data-mesher[212]: time=2026-09-22T15:03:58.586Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331
container-test-run-data-mesher> gamma # [1583224.166184] gamma data-mesher[212]: time=2026-09-22T15:03:58.589Z level=INFO msg="peer connected" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V remote_addr=/ip4/192.168.1.2/tcp/7946
container-test-run-data-mesher> gamma # [1583224.168059] gamma data-mesher[212]: time=2026-09-22T15:03:58.591Z level=INFO msg="peer connected" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD remote_addr=/ip4/192.168.1.1/tcp/7946
container-test-run-data-mesher> gamma # [1583224.180090] gamma systemd-logind[231]: New seat seat0.
container-test-run-data-mesher> gamma # [1583224.180231] gamma systemd[1]: Started User Login Management.
container-test-run-data-mesher> gamma # [1583224.181233] gamma systemd[1]: Starting linger-users.service...
container-test-run-data-mesher> gamma # [1583224.188922] gamma systemd[1]: linger-users.service: Deactivated successfully.
container-test-run-data-mesher> gamma # [1583224.189030] gamma systemd[1]: Finished linger-users.service.
container-test-run-data-mesher> alpha # [1583224.448099] alpha systemd-networkd[198]: eth1: Gained IPv6LL
container-test-run-data-mesher> alpha # [1583225.219016] alpha data-mesher[212]: time=2026-09-22T15:03:59.642Z level=INFO msg="peer connected" peer_id=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V remote_addr=/ip6zone/eth1/ip6/fe80::3404:8cff:fe8b:7939/tcp/7946
container-test-run-data-mesher> alpha # [1583225.331107] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> alpha # [1583225.331645] alpha systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> beta # [1583225.218853] beta data-mesher[212]: time=2026-09-22T15:03:59.642Z level=INFO msg="peer connected" peer_id=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD remote_addr=/ip6/2001:db8:1::1/tcp/7946
container-test-run-data-mesher> beta # [1583225.330090] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> beta # [1583225.330944] beta systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> gamma # [1583225.334105] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
container-test-run-data-mesher> gamma # [1583225.334594] gamma systemd[1]: Finished Save Transient machine-id to Disk.
container-test-run-data-mesher> alpha: still waiting for container 'alpha' to reach ready state...
container-test-run-data-mesher> beta # [1583234.163247] beta data-mesher[212]: time=2026-09-22T15:04:08.586Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> beta # [1583234.163247] beta data-mesher[212]: time=2026-09-22T15:04:08.586Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583234.163918] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583234.163918] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583234.163978] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583234.163978] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583234.164142] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="server started"
container-test-run-data-mesher> beta # [1583234.164207] beta data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> beta # [1583234.164297] beta systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> beta # [1583234.164469] beta systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> beta # [1583234.164548] beta systemd[1]: Startup finished in 12.762s.
container-test-run-data-mesher> gamma # [1583234.164080] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> gamma # [1583234.164080] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583234.164389] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583234.164389] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583234.164428] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="server started"
container-test-run-data-mesher> gamma # [1583234.164465] gamma data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> gamma # [1583234.164491] gamma systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> gamma # [1583234.164627] gamma systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> gamma # [1583234.170041] gamma systemd[1]: Startup finished in 12.773s.
container-test-run-data-mesher> alpha: (finished: waiting for unit data-mesher.service, in 13.65 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/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key
container-test-run-data-mesher> alpha # [1583234.163368] alpha data-mesher[212]: time=2026-09-22T15:04:08.586Z level=INFO msg="performing state exchange with peers on join" count=1
container-test-run-data-mesher> alpha # [1583234.163368] alpha data-mesher[212]: time=2026-09-22T15:04:08.586Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583234.163774] alpha data-mesher[212]: time=2026-09-22T15:04:08.586Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583234.163774] alpha data-mesher[212]: time=2026-09-22T15:04:08.586Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583234.164162] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583234.164162] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583234.164227] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="server started"
container-test-run-data-mesher> alpha # [1583234.164265] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="starting expired-file sweeper" interval=1m0s
container-test-run-data-mesher> alpha # [1583234.164291] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583234.164351] alpha data-mesher[212]: time=2026-09-22T15:04:08.587Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583234.164310] alpha systemd[1]: Started data mesher daemon.
container-test-run-data-mesher> alpha # [1583234.164467] alpha systemd[1]: Reached target Multi-User System.
container-test-run-data-mesher> alpha # [1583234.170041] alpha systemd[1]: Startup finished in 12.645s.
container-test-run-data-mesher> alpha # [1583234.614137] alpha data-mesher[212]: time=2026-09-22T15:04:09.037Z level=INFO msg=http_request uri=/files/test_file status=204
container-test-run-data-mesher> alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/v4mkgp543y0bvj1gi240ypfx69ql1qmn-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/v4mkgp543y0bvj1gi240ypfx69ql1qmn-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 # [1583239.166063] beta data-mesher[212]: time=2026-09-22T15:04:13.589Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [1583239.165157] alpha data-mesher[212]: time=2026-09-22T15:04:13.588Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583239.166063] beta data-mesher[212]: time=2026-09-22T15:04:13.589Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> gamma # [1583239.165442] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583239.166849] beta data-mesher[212]: time=2026-09-22T15:04:13.590Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583239.165453] alpha data-mesher[212]: time=2026-09-22T15:04:13.588Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> beta # [1583239.166849] beta data-mesher[212]: time=2026-09-22T15:04:13.590Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> gamma # [1583239.165442] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> alpha # [1583239.165687] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> gamma # [1583239.165751] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583239.166912] beta data-mesher[212]: time=2026-09-22T15:04:13.590Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [1583239.165687] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> gamma # [1583239.165751] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> alpha # [1583239.165789] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583239.165751] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file
container-test-run-data-mesher> alpha # [1583239.165789] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> gamma # [1583239.165751] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> alpha # [1583239.165789] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> gamma # [1583239.165751] gamma data-mesher[212]: time=2026-09-22T15:04:13.588Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-22 15:04:09.036 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> alpha # [1583239.165842] alpha data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="received file request" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file
container-test-run-data-mesher> gamma # [1583239.165943] gamma data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> alpha # [1583239.166760] alpha data-mesher[212]: time=2026-09-22T15:04:13.590Z level=INFO msg="file transfer complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file
container-test-run-data-mesher> gamma # [1583239.166021] gamma data-mesher[212]: time=2026-09-22T15:04:13.589Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file
container-test-run-data-mesher> gamma # [1583239.166021] gamma data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583239.166021] gamma data-mesher[212]: time=2026-09-22T15:04:13.589Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583239.166591] gamma data-mesher[212]: time=2026-09-22T15:04:13.589Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583239.166745] gamma data-mesher[212]: time=2026-09-22T15:04:13.590Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583239.170648] gamma data-mesher[212]: time=2026-09-22T15:04:13.593Z level=INFO msg="download complete" name=test_file signed_at="2026-09-22 15:04:09.036 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=5.029402ms
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_file
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="scheduling file download" name=test_file
container-test-run-data-mesher> beta # [1583244.167129] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-22 15:04:09.036 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583244.167702] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583244.167702] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="new file detected" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE name=test_file name=test_file
container-test-run-data-mesher> beta # [1583244.167702] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> beta # [1583244.167702] beta data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [1583244.193607] beta data-mesher[212]: time=2026-09-22T15:04:18.616Z level=INFO msg="download complete" name=test_file signed_at="2026-09-22 15:04:09.036 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=26.445494ms
container-test-run-data-mesher> gamma # [1583244.166429] gamma data-mesher[212]: time=2026-09-22T15:04:18.589Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [1583244.166429] gamma data-mesher[212]: time=2026-09-22T15:04:18.589Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583244.167051] gamma data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583244.167082] gamma data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583244.167112] gamma data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583244.167368] gamma data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583244.167368] gamma data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583244.166390] alpha data-mesher[212]: time=2026-09-22T15:04:18.589Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [1583244.166798] alpha data-mesher[212]: time=2026-09-22T15:04:18.589Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583244.166878] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583244.166908] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583244.167171] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583244.167171] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583244.167237] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [1583244.167467] alpha data-mesher[212]: time=2026-09-22T15:04:18.590Z level=INFO msg="received file request" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file
container-test-run-data-mesher> alpha # [1583244.167674] alpha data-mesher[212]: time=2026-09-22T15:04:18.591Z level=INFO msg="file transfer complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_file
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 10.05 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.02 seconds)
container-test-run-data-mesher> beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.13 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 # [1583244.808803] beta data-mesher[212]: time=2026-09-22T15:04:19.232Z level=INFO msg=http_request uri=/files/test_file status=204
container-test-run-data-mesher> beta # [1583249.168984] beta data-mesher[212]: time=2026-09-22T15:04:23.592Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583249.169329] beta data-mesher[212]: time=2026-09-22T15:04:23.592Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583249.172140] beta data-mesher[212]: time=2026-09-22T15:04:23.595Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583249.172140] beta data-mesher[212]: time=2026-09-22T15:04:23.595Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583249.189305] beta data-mesher[212]: time=2026-09-22T15:04:23.612Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583249.189305] beta data-mesher[212]: time=2026-09-22T15:04:23.612Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583249.189305] beta data-mesher[212]: time=2026-09-22T15:04:23.612Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583249.167838] gamma data-mesher[212]: time=2026-09-22T15:04:23.590Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [1583249.167838] gamma data-mesher[212]: time=2026-09-22T15:04:23.590Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583249.171726] gamma data-mesher[212]: time=2026-09-22T15:04:23.595Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583249.171803] gamma data-mesher[212]: time=2026-09-22T15:04:23.595Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> gamma # [1583249.171803] gamma data-mesher[212]: time=2026-09-22T15:04:23.595Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [1583249.171193] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [1583249.171193] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583249.171638] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583249.171638] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583249.171638] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583249.171638] alpha data-mesher[212]: time=2026-09-22T15:04:23.594Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583249.172813] alpha data-mesher[212]: time=2026-09-22T15:04:23.596Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583249.184724] alpha data-mesher[212]: time=2026-09-22T15:04:23.607Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=true
container-test-run-data-mesher> alpha # [1583249.184724] alpha data-mesher[212]: time=2026-09-22T15:04:23.607Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=false
container-test-run-data-mesher> alpha # [1583249.184724] alpha data-mesher[212]: time=2026-09-22T15:04:23.607Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> alpha # [1583249.184724] alpha data-mesher[212]: time=2026-09-22T15:04:23.608Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.08 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.01 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 # [1583254.172245] beta data-mesher[212]: time=2026-09-22T15:04:28.595Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583254.172245] beta data-mesher[212]: time=2026-09-22T15:04:28.595Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583254.189427] beta data-mesher[212]: time=2026-09-22T15:04:28.612Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583254.189466] beta data-mesher[212]: time=2026-09-22T15:04:28.612Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> beta # [1583254.189671] beta data-mesher[212]: time=2026-09-22T15:04:28.613Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583254.189695] beta data-mesher[212]: time=2026-09-22T15:04:28.613Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> beta # [1583254.189708] beta data-mesher[212]: time=2026-09-22T15:04:28.613Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583254.171992] gamma data-mesher[212]: time=2026-09-22T15:04:28.595Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [1583254.171992] gamma data-mesher[212]: time=2026-09-22T15:04:28.595Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> gamma # [1583254.172358] gamma data-mesher[212]: time=2026-09-22T15:04:28.595Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583254.175246] gamma data-mesher[212]: time=2026-09-22T15:04:28.598Z level=DEBUG msg="imported tombstone" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V name=test_file written=true
container-test-run-data-mesher> gamma # [1583254.175246] gamma data-mesher[212]: time=2026-09-22T15:04:28.598Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> gamma # [1583254.175310] gamma data-mesher[212]: time=2026-09-22T15:04:28.598Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583254.185212] gamma data-mesher[212]: time=2026-09-22T15:04:28.608Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583254.185212] gamma data-mesher[212]: time=2026-09-22T15:04:28.608Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583254.189592] gamma data-mesher[212]: time=2026-09-22T15:04:28.612Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583254.189592] gamma data-mesher[212]: time=2026-09-22T15:04:28.612Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583254.184990] alpha data-mesher[212]: time=2026-09-22T15:04:28.608Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [1583254.184990] alpha data-mesher[212]: time=2026-09-22T15:04:28.608Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> alpha # [1583254.185363] alpha data-mesher[212]: time=2026-09-22T15:04:28.608Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583254.185363] alpha data-mesher[212]: time=2026-09-22T15:04:28.608Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> alpha # [1583254.185363] alpha data-mesher[212]: time=2026-09-22T15:04:28.608Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.03 seconds)
container-test-run-data-mesher> alpha: must succeed: cat /nix/store/yh5m00imp0p5g1zrjprzlc089ql5nn61-per-machine-alpha-data-mesher-node-identity_identity.pub
container-test-run-data-mesher> alpha: (finished: must succeed: cat /nix/store/yh5m00imp0p5g1zrjprzlc089ql5nn61-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 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/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-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/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, in 0.00 seconds)
container-test-run-data-mesher> beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha # [1583254.960969] alpha data-mesher[212]: time=2026-09-22T15:04:29.384Z level=INFO msg=http_request uri=/files/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g status=204
container-test-run-data-mesher> beta # [1583259.176462] beta data-mesher[212]: time=2026-09-22T15:04:33.599Z level=INFO msg="received state sync from peer" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583259.176462] beta data-mesher[212]: time=2026-09-22T15:04:33.599Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> beta # [1583259.190774] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> beta # [1583259.190774] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=DEBUG msg="initiating state exchange" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583259.191199] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583259.191268] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> beta # [1583259.191284] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="state exchange complete" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD timeout=5s
container-test-run-data-mesher> beta # [1583259.191284] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> beta # [1583259.191315] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="scheduling file download" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> beta # [1583259.191329] beta data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="downloading file" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 15:04:29.382 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> beta # [1583259.192445] beta data-mesher[212]: time=2026-09-22T15:04:33.615Z level=INFO msg="download complete" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 15:04:29.382 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=1.129367ms
container-test-run-data-mesher> gamma # [1583259.176090] gamma data-mesher[212]: time=2026-09-22T15:04:33.599Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> gamma # [1583259.176090] gamma data-mesher[212]: time=2026-09-22T15:04:33.599Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> gamma # [1583259.176530] gamma data-mesher[212]: time=2026-09-22T15:04:33.599Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> gamma # [1583259.176551] gamma data-mesher[212]: time=2026-09-22T15:04:33.599Z level=INFO msg="state exchange complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V timeout=5s
container-test-run-data-mesher> gamma # [1583259.176551] gamma data-mesher[212]: time=2026-09-22T15:04:33.599Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> gamma # [1583259.186438] gamma data-mesher[212]: time=2026-09-22T15:04:33.609Z level=INFO msg="received state sync from peer" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583259.186438] gamma data-mesher[212]: time=2026-09-22T15:04:33.609Z level=INFO msg="merging remote state" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583259.186570] gamma data-mesher[212]: time=2026-09-22T15:04:33.609Z level=DEBUG msg="new file detected" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD name=test_file name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> gamma # [1583259.186656] gamma data-mesher[212]: time=2026-09-22T15:04:33.609Z level=INFO msg="scheduling file download" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> gamma # [1583259.186656] gamma data-mesher[212]: time=2026-09-22T15:04:33.609Z level=INFO msg="downloading file" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 15:04:29.382 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD
container-test-run-data-mesher> gamma # [1583259.187920] gamma data-mesher[212]: time=2026-09-22T15:04:33.611Z level=INFO msg="download complete" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g signed_at="2026-09-22 15:04:29.382 +0000 UTC" signed_by="pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g=" peer=12D3KooWLxqEgicuGhvqCQw8x8dzqmzL4ZAySwTYTAYvS7Kh1sKD written=true elapsed=1.265143ms
container-test-run-data-mesher> alpha # [1583259.185865] alpha data-mesher[212]: time=2026-09-22T15:04:33.609Z level=DEBUG msg="attempting push/pull" peer_count=2
container-test-run-data-mesher> alpha # [1583259.185865] alpha data-mesher[212]: time=2026-09-22T15:04:33.609Z level=DEBUG msg="initiating state exchange" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> alpha # [1583259.186669] alpha data-mesher[212]: time=2026-09-22T15:04:33.609Z level=INFO msg="merging remote state" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE
container-test-run-data-mesher> alpha # [1583259.186710] alpha data-mesher[212]: time=2026-09-22T15:04:33.610Z level=INFO msg="state exchange complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE timeout=5s
container-test-run-data-mesher> alpha # [1583259.186710] alpha data-mesher[212]: time=2026-09-22T15:04:33.610Z level=DEBUG msg="push/pull successful" interval=5s
container-test-run-data-mesher> alpha # [1583259.186819] alpha data-mesher[212]: time=2026-09-22T15:04:33.610Z level=INFO msg="received file request" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha # [1583259.187587] alpha data-mesher[212]: time=2026-09-22T15:04:33.610Z level=INFO msg="file transfer complete" peer=12D3KooWHmAX2pXTbLUM81o5LX1bYS1pRkTpVoMDsi5cQgA3NCsE network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha # [1583259.191081] alpha data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="received state sync from peer" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583259.191081] alpha data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="merging remote state" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V
container-test-run-data-mesher> alpha # [1583259.191448] alpha data-mesher[212]: time=2026-09-22T15:04:33.614Z level=INFO msg="received file request" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha # [1583259.192165] alpha data-mesher[212]: time=2026-09-22T15:04:33.615Z level=INFO msg="file transfer complete" peer=12D3KooWMq5YeXhZGe1bTkdiPfQi73VfrgjRLcoxPKAeSbyaki6V network="YOI7Swaq/VpBBMG9waW2ZKOViszLTkkEoxYn8j+PSO8=" name=test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, in 5.02 seconds)
container-test-run-data-mesher> gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g, 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/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub
container-test-run-data-mesher> Error: failed to update file: 403 Forbidden, signer pZvO+VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD+g= is not authorized for this file test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g
container-test-run-data-mesher> alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/pZvO-VdOjTZLTn87vyczO0O84SOATeblHBlFn6bxD-g' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/pa2hsk0bsvbf2yzgkkdz06ibpsgxil9q-shared-data-mesher-network_network.pub, in 0.01 seconds)
container-test-run-data-mesher> (finished: run the VM test script, in 39.07 seconds)
container-test-run-data-mesher> test script finished in 39.15s
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.24 seconds)

post-build step Upload to niks3: ok
time=2026-09-22T15:04:35.121Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)"
time=2026-09-22T15:04:35.653Z level=INFO msg="Uploading 1 narinfos"
time=2026-09-22T15:04:35.921Z level=INFO msg="Upload complete. (936ms)"