container-test-run-data-mesher
checks.aarch64-linux.data-mesher
· build #530
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)45Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 alpha, beta, gamma,9 vlan1,10 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_ssh11start all VMs12alpha: systemd-nspawn running (pid 52)13alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal...14beta: systemd-nspawn running (pid 55)15beta: Waiting for journal at /build/vm-state-beta/var/log/journal...16gamma: systemd-nspawn running (pid 58)17gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal...18(finished: start all VMs, in 0.00 seconds)19alpha: waiting for unit data-mesher.service20nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE21nixos-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.22nixos-nspawn(beta): TAP vde-tap1 not found; container will be isolated from VDE23nixos-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.24nixos-nspawn(gamma): TAP vde-tap1 not found; container will be isolated from VDE25nixos-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.26Note: 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.27Note: 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.28Note: 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.29░ Spawning container gamma on /build/vm-state-gamma.30░ Spawning container alpha on /build/vm-state-alpha.31░ Spawning container beta on /build/vm-state-beta.32alpha # No journal files were found.33alpha # No journal boot entry found for the specified boot (+0).34beta # No journal files were found.35beta # No journal boot entry found for the specified boot (+0).36gamma # No journal files were found.37gamma # No journal boot entry found for the specified boot (+0).38alpha # [7209337.666533] alpha systemd-journald[87]: Journal started39alpha # [7209337.666609] alpha systemd-journald[87]: Runtime Journal (/run/log/journal/d60d9ccfdc99449ca50ebcc7e8198fab) is 8M, max 2.5G, 2.4G free.40alpha # [7209337.688445] alpha systemd[1]: Starting Flush Journal to Persistent Storage...41alpha # [7209337.689352] alpha systemd[1]: Starting Network Name Resolution...42alpha # [7209337.740389] alpha systemd[1]: Starting Create Static Device Nodes in /dev...43alpha # [7209337.748500] alpha systemd-journald[87]: Time spent on flushing to /var/log/journal/d60d9ccfdc99449ca50ebcc7e8198fab is 1.665ms for 5 entries.44alpha # [7209337.748500] alpha systemd-journald[87]: System Journal (/var/log/journal/d60d9ccfdc99449ca50ebcc7e8198fab) is 8M, max 4G, 3.9G free.45alpha # [7209337.757016] alpha systemd[1]: Finished Create Static Device Nodes in /dev.46alpha # [7209337.757304] alpha systemd[1]: Reached target Preparation for Local File Systems.47alpha # [7209337.757403] alpha systemd[1]: Reached target Local File Systems.48alpha # [7209337.758206] alpha systemd[1]: Listening on Boot Loader Control Service Socket.49alpha # [7209337.758251] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container50alpha # [7209337.759141] alpha systemd[1]: Starting Save Transient machine-id to Disk...51alpha # [7209337.759172] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys52alpha # [7209337.795985] alpha systemd[1]: Finished Flush Journal to Persistent Storage.53alpha # [7209337.797473] alpha systemd[1]: Starting Create System Files and Directories...54alpha # [7209337.807186] alpha systemd[1]: Finished Firewall.55alpha # [7209337.807318] alpha systemd[1]: Reached target Preparation for Network.56alpha # [7209337.807553] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.57alpha # [7209337.808602] alpha systemd[1]: Starting Network Management...58alpha # [7209337.817930] alpha systemd-tmpfiles[191]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted59alpha # [7209337.818118] alpha systemd-tmpfiles[191]: fchmod() of /var/log/journal failed: Operation not permitted60alpha # [7209337.818245] alpha systemd-tmpfiles[191]: fchmod() of /var/log/journal/d60d9ccfdc99449ca50ebcc7e8198fab failed: Operation not permitted61alpha # [7209337.818439] alpha systemd-tmpfiles[191]: fchmod() of /run/log/journal failed: Operation not permitted62alpha # [7209337.820529] alpha systemd[1]: Finished Create System Files and Directories.63alpha # [7209337.821634] alpha systemd[1]: Starting Rebuild Journal Catalog...64alpha # [7209337.822447] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...65alpha # [7209337.834188] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.66alpha # [7209337.840521] alpha systemd[1]: Finished Rebuild Journal Catalog.67alpha # [7209337.841548] alpha systemd[1]: Starting Update is Completed...68alpha # [7209337.851656] alpha systemd[1]: Finished Update is Completed.69alpha # [7209338.462934] alpha systemd-networkd[197]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted70beta # [7209337.654840] beta systemd-journald[87]: Journal started71alpha # [7209338.463022] alpha systemd-networkd[197]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted72beta # [7209337.654896] beta systemd-journald[87]: Runtime Journal (/run/log/journal/7c51ccb851c04e12862caadd24c8257c) is 8M, max 2.5G, 2.4G free.73alpha # [7209338.469712] alpha 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.74beta # [7209337.677022] beta systemd[1]: Finished Create Static Device Nodes in /dev gracefully.75alpha # [7209338.469882] alpha 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.76beta # [7209337.688393] beta systemd[1]: Starting Flush Journal to Persistent Storage...77alpha # [7209338.470059] alpha systemd-networkd[197]: lo: Link UP78beta # [7209337.690027] beta systemd[1]: Starting Network Name Resolution...79alpha # [7209338.470063] alpha systemd-networkd[197]: lo: Gained carrier80beta # [7209337.740412] beta systemd[1]: Starting Create Static Device Nodes in /dev...81alpha # [7209338.470280] alpha systemd-networkd[197]: eth1: Configuring with /etc/systemd/network/40-eth1.network.82beta # [7209337.746071] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/7c51ccb851c04e12862caadd24c8257c is 1.506ms for 6 entries.83alpha # [7209338.470651] alpha systemd[1]: Started Network Management.84beta # [7209337.746071] beta systemd-journald[87]: System Journal (/var/log/journal/7c51ccb851c04e12862caadd24c8257c) is 8M, max 4G, 3.9G free.85alpha # [7209338.504342] alpha systemd-networkd[197]: eth1: Link UP86beta # [7209337.765791] beta systemd[1]: Finished Create Static Device Nodes in /dev.87alpha # [7209338.504378] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...88beta # [7209337.766515] beta systemd[1]: Reached target Preparation for Local File Systems.89alpha # [7209338.504821] alpha systemd-networkd[197]: eth1: Gained carrier90beta # [7209337.766635] beta systemd[1]: Reached target Local File Systems.91alpha # [7209338.550155] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.92beta # [7209337.767442] beta systemd[1]: Listening on Boot Loader Control Service Socket.93beta # [7209337.767488] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container94beta # [7209337.768395] beta systemd[1]: Starting Save Transient machine-id to Disk...95beta # [7209337.768430] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys96beta # [7209337.784043] beta systemd[1]: Finished Flush Journal to Persistent Storage.97beta # [7209337.785788] beta systemd[1]: Starting Create System Files and Directories...98beta # [7209337.805571] beta systemd[1]: Finished Firewall.99beta # [7209337.805710] beta systemd[1]: Reached target Preparation for Network.100beta # [7209337.805911] beta systemd[1]: Listening on Network Management Resolve Hook Socket.101beta # [7209337.806942] beta systemd[1]: Starting Network Management...102beta # [7209337.810392] beta systemd-tmpfiles[184]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted103beta # [7209337.810568] beta systemd-tmpfiles[184]: fchmod() of /var/log/journal failed: Operation not permitted104beta # [7209337.810685] beta systemd-tmpfiles[184]: fchmod() of /var/log/journal/7c51ccb851c04e12862caadd24c8257c failed: Operation not permitted105beta # [7209337.810865] beta systemd-tmpfiles[184]: fchmod() of /run/log/journal failed: Operation not permitted106beta # [7209337.813770] beta systemd[1]: Finished Create System Files and Directories.107beta # [7209337.814898] beta systemd[1]: Starting Rebuild Journal Catalog...108beta # [7209337.816160] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...109beta # [7209337.827812] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.110beta # [7209337.833955] beta systemd[1]: Finished Rebuild Journal Catalog.111beta # [7209337.835392] beta systemd[1]: Starting Update is Completed...112beta # [7209337.845886] beta systemd[1]: Finished Update is Completed.113beta # [7209338.462885] beta systemd-networkd[197]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted114beta # [7209338.462978] beta systemd-networkd[197]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted115beta # [7209338.472133] 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.116beta # [7209338.472308] 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.117beta # [7209338.472467] beta systemd-networkd[197]: lo: Link UP118beta # [7209338.472471] beta systemd-networkd[197]: lo: Gained carrier119beta # [7209338.472648] beta systemd-networkd[197]: eth1: Configuring with /etc/systemd/network/40-eth1.network.120beta # [7209338.473030] beta systemd[1]: Started Network Management.121beta # [7209338.504419] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...122beta # [7209338.504606] beta systemd-networkd[197]: eth1: Link UP123beta # [7209338.504875] beta systemd-networkd[197]: eth1: Gained carrier124beta # [7209338.550267] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.125gamma # [7209337.666454] gamma systemd-journald[87]: Journal started126gamma # [7209337.666535] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/e031b53a5a7140b7a0c0312a1a4f779b) is 8M, max 2.5G, 2.4G free.127gamma # [7209337.688364] gamma systemd[1]: Starting Flush Journal to Persistent Storage...128gamma # [7209337.689444] gamma systemd[1]: Starting Network Name Resolution...129gamma # [7209337.740377] gamma systemd[1]: Starting Create Static Device Nodes in /dev...130gamma # [7209337.747123] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/e031b53a5a7140b7a0c0312a1a4f779b is 1.527ms for 5 entries.131gamma # [7209337.747123] gamma systemd-journald[87]: System Journal (/var/log/journal/e031b53a5a7140b7a0c0312a1a4f779b) is 8M, max 4G, 3.9G free.132gamma # [7209337.756958] gamma systemd[1]: Finished Create Static Device Nodes in /dev.133gamma # [7209337.757245] gamma systemd[1]: Reached target Preparation for Local File Systems.134gamma # [7209337.757335] gamma systemd[1]: Reached target Local File Systems.135gamma # [7209337.758143] gamma systemd[1]: Listening on Boot Loader Control Service Socket.136gamma # [7209337.758192] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container137gamma # [7209337.759140] gamma systemd[1]: Starting Save Transient machine-id to Disk...138gamma # [7209337.759171] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys139gamma # [7209337.784765] gamma systemd[1]: Finished Flush Journal to Persistent Storage.140gamma # [7209337.785872] gamma systemd[1]: Starting Create System Files and Directories...141gamma # [7209337.807027] gamma systemd-tmpfiles[179]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted142gamma # [7209337.807211] gamma systemd-tmpfiles[179]: fchmod() of /var/log/journal failed: Operation not permitted143gamma # [7209337.807332] gamma systemd-tmpfiles[179]: fchmod() of /var/log/journal/e031b53a5a7140b7a0c0312a1a4f779b failed: Operation not permitted144gamma # [7209337.807512] gamma systemd-tmpfiles[179]: fchmod() of /run/log/journal failed: Operation not permitted145gamma # [7209337.812132] gamma systemd[1]: Finished Create System Files and Directories.146gamma # [7209337.812436] gamma systemd[1]: Finished Firewall.147gamma # [7209337.813025] gamma systemd[1]: Reached target Preparation for Network.148gamma # [7209337.813380] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.149gamma # [7209337.814423] gamma systemd[1]: Starting Rebuild Journal Catalog...150gamma # [7209337.815824] gamma systemd[1]: Starting Network Management...151gamma # [7209337.816557] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...152gamma # [7209337.828179] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.153gamma # [7209337.833927] gamma systemd[1]: Finished Rebuild Journal Catalog.154gamma # [7209337.835200] gamma systemd[1]: Starting Update is Completed...155gamma # [7209337.846432] gamma systemd[1]: Finished Update is Completed.156gamma # [7209338.438219] gamma systemd-networkd[199]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted157gamma # [7209338.438317] gamma systemd-networkd[199]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted158gamma # [7209338.446407] gamma systemd-networkd[199]: /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.159gamma # [7209338.446573] gamma systemd-networkd[199]: /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.160gamma # [7209338.446751] gamma systemd-networkd[199]: lo: Link UP161gamma # [7209338.446756] gamma systemd-networkd[199]: lo: Gained carrier162gamma # [7209338.446966] gamma systemd-networkd[199]: eth1: Configuring with /etc/systemd/network/40-eth1.network.163gamma # [7209338.447638] gamma systemd[1]: Started Network Management.164gamma # [7209338.447752] gamma systemd-networkd[199]: eth1: Link UP165gamma # [7209338.448102] gamma systemd-networkd[199]: eth1: Gained carrier166gamma # [7209338.448843] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...167gamma # [7209338.511943] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.168gamma # [7209338.782179] gamma systemd-resolved[119]: Positive Trust Anchors:169gamma # [7209338.782192] gamma systemd-resolved[119]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d170gamma # [7209338.782195] gamma systemd-resolved[119]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16171gamma # [7209338.782230] gamma systemd-resolved[119]: 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 test172gamma # [7209338.805495] gamma systemd-resolved[119]: Using system hostname 'gamma'.173gamma # [7209338.806982] gamma systemd[1]: Started Network Name Resolution.174gamma # [7209338.807063] gamma systemd[1]: Reached target Network.175gamma # [7209338.807134] gamma systemd[1]: Reached target System Initialization.176gamma # [7209338.807175] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container177gamma # [7209338.807200] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.178gamma # [7209338.807215] gamma systemd[1]: Reached target Timer Units.179gamma # [7209338.807336] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.180gamma # [7209338.807451] gamma systemd[1]: Listening on Nix Daemon Socket.181gamma # [7209338.807553] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.182gamma # [7209338.807574] gamma systemd[1]: Reached target Socket Units.183gamma # [7209338.807608] gamma systemd[1]: Reached target Basic System.184gamma # [7209338.809249] gamma systemd[1]: Starting data mesher daemon...185gamma # [7209338.810030] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...186gamma # [7209338.810820] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...187gamma # [7209338.811985] gamma systemd[1]: Starting D-Bus System Message Bus...188gamma # [7209338.971573] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.189alpha # [7209338.803058] alpha systemd-resolved[122]: Positive Trust Anchors:190alpha # [7209338.803071] alpha systemd-resolved[122]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d191alpha # [7209338.803076] alpha systemd-resolved[122]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16192alpha # [7209338.803116] alpha systemd-resolved[122]: 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 test193alpha # [7209338.828559] alpha systemd-resolved[122]: Using system hostname 'alpha'.194alpha # [7209338.830009] alpha systemd[1]: Started Network Name Resolution.195alpha # [7209338.830103] alpha systemd[1]: Reached target Network.196alpha # [7209338.830187] alpha systemd[1]: Reached target System Initialization.197alpha # [7209338.830245] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container198alpha # [7209338.830283] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.199alpha # [7209338.830313] alpha systemd[1]: Reached target Timer Units.200alpha # [7209338.830469] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.201alpha # [7209338.830634] alpha systemd[1]: Listening on Nix Daemon Socket.202alpha # [7209338.830791] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.203alpha # [7209338.830832] alpha systemd[1]: Reached target Socket Units.204alpha # [7209338.830882] alpha systemd[1]: Reached target Basic System.205alpha # [7209338.956476] alpha systemd[1]: Starting data mesher daemon...206alpha # [7209338.957327] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...207alpha # [7209338.958124] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...208alpha # [7209338.959259] alpha systemd[1]: Starting D-Bus System Message Bus...209alpha # [7209338.977571] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.210beta # [7209338.815990] beta systemd-resolved[121]: Positive Trust Anchors:211beta # [7209338.816014] beta systemd-resolved[121]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d212beta # [7209338.816019] beta systemd-resolved[121]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16213beta # [7209338.816052] beta systemd-resolved[121]: 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 test214beta # [7209338.838978] beta systemd-resolved[121]: Using system hostname 'beta'.215beta # [7209338.840448] beta systemd[1]: Started Network Name Resolution.216beta # [7209338.840586] beta systemd[1]: Reached target Network.217beta # [7209338.840700] beta systemd[1]: Reached target System Initialization.218beta # [7209338.840797] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container219beta # [7209338.840847] beta systemd[1]: Started Daily Cleanup of Temporary Directories.220beta # [7209338.840885] beta systemd[1]: Reached target Timer Units.221beta # [7209338.841111] beta systemd[1]: Listening on D-Bus System Message Bus Socket.222beta # [7209338.841329] beta systemd[1]: Listening on Nix Daemon Socket.223beta # [7209338.841541] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.224beta # [7209338.841583] beta systemd[1]: Reached target Socket Units.225beta # [7209338.841667] beta systemd[1]: Reached target Basic System.226beta # [7209338.956556] beta systemd[1]: Starting data mesher daemon...227beta # [7209338.957921] beta systemd[1]: Starting Import lastlog data into lastlog2 database...228beta # [7209338.959405] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...229beta # [7209338.961581] beta systemd[1]: Starting D-Bus System Message Bus...230beta # [7209338.975836] beta systemd[1]: Finished Import lastlog data into lastlog2 database.231beta # [7209339.160511] beta nsncd[211]: Aug 31 09:59:25.213 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"232beta # [7209339.160531] beta systemd[1]: Started Name Service Cache Daemon (nsncd).233beta # [7209339.160592] beta systemd[1]: Reached target Host and Network Name Lookups.234beta # [7209339.160649] beta systemd[1]: Reached target User and Group Name Lookups.235beta # [7209339.193258] beta systemd[1]: Starting User Login Management...236beta # [7209339.194355] beta systemd[1]: Starting Permit User Sessions...237beta # [7209339.205101] beta systemd[1]: Finished Permit User Sessions.238beta # [7209339.206203] beta systemd[1]: Started Console Getty.239beta # [7209339.206247] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0240beta # [7209339.206267] beta systemd[1]: Reached target Login Prompts.241beta # [7209339.298955] beta dbus-broker-launch[212]: Looking up NSS user entry for 'systemd-timesync'...242beta # [7209339.299730] beta dbus-broker-launch[212]: NSS returned no entry for 'systemd-timesync'243beta # [7209339.299730] beta dbus-broker-launch[212]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"244beta # [7209339.300247] beta systemd[1]: Started D-Bus System Message Bus.245beta # [7209339.307151] beta dbus-broker-launch[212]: Ready246gamma # [7209339.149957] gamma nsncd[211]: Aug 31 09:59:25.201 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"247gamma # [7209339.148870] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).248gamma # [7209339.148930] gamma systemd[1]: Reached target Host and Network Name Lookups.249gamma # [7209339.148990] gamma systemd[1]: Reached target User and Group Name Lookups.250gamma # [7209339.150136] gamma systemd[1]: Starting User Login Management...251gamma # [7209339.151068] gamma systemd[1]: Starting Permit User Sessions...252gamma # [7209339.199053] gamma systemd[1]: Finished Permit User Sessions.253gamma # [7209339.200419] gamma systemd[1]: Started Console Getty.254gamma # [7209339.200464] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0255gamma # [7209339.200485] gamma systemd[1]: Reached target Login Prompts.256gamma # [7209339.319166] gamma dbus-broker-launch[212]: Looking up NSS user entry for 'systemd-timesync'...257gamma # [7209339.319844] gamma dbus-broker-launch[212]: NSS returned no entry for 'systemd-timesync'258gamma # [7209339.319844] gamma dbus-broker-launch[212]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"259gamma # [7209339.320225] gamma systemd[1]: Started D-Bus System Message Bus.260gamma # [7209339.327075] gamma dbus-broker-launch[212]: Ready261alpha # [7209339.148980] alpha nsncd[211]: Aug 31 09:59:25.201 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"262alpha # [7209339.148626] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).263alpha # [7209339.148694] alpha systemd[1]: Reached target Host and Network Name Lookups.264alpha # [7209339.148779] alpha systemd[1]: Reached target User and Group Name Lookups.265alpha # [7209339.150129] alpha systemd[1]: Starting User Login Management...266alpha # [7209339.151354] alpha systemd[1]: Starting Permit User Sessions...267alpha # [7209339.199360] alpha systemd[1]: Finished Permit User Sessions.268alpha # [7209339.200558] alpha systemd[1]: Started Console Getty.269alpha # [7209339.200612] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0270alpha # [7209339.200635] alpha systemd[1]: Reached target Login Prompts.271alpha # [7209339.318488] alpha dbus-broker-launch[212]: Looking up NSS user entry for 'systemd-timesync'...272alpha # [7209339.319295] alpha dbus-broker-launch[212]: NSS returned no entry for 'systemd-timesync'273alpha # [7209339.319295] alpha dbus-broker-launch[212]: Invalid user-name in /nix/store/cpw251a8nnv83rza5mdsgkafc9msqh5c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"274alpha # [7209339.319714] alpha systemd[1]: Started D-Bus System Message Bus.275alpha # [7209339.326642] alpha dbus-broker-launch[212]: Ready276gamma # [7209339.488247] gamma systemd-networkd[199]: eth1: Gained IPv6LL277gamma # [7209339.589361] gamma data-mesher[209]: time=2026-08-31T09:59:25.642Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]278gamma # [7209339.590424] gamma data-mesher[209]: time=2026-08-31T09:59:25.643Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r279gamma # [7209339.590466] gamma data-mesher[209]: time=2026-08-31T09:59:25.643Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml280gamma # [7209339.723707] gamma systemd-logind[228]: New seat seat0.281gamma # [7209339.723843] gamma systemd[1]: Started User Login Management.282gamma # [7209339.776509] gamma systemd[1]: Starting linger-users.service...283beta # [7209339.588062] beta data-mesher[209]: time=2026-08-31T09:59:25.640Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]284beta # [7209339.588484] beta data-mesher[209]: time=2026-08-31T09:59:25.641Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498285alpha # [7209339.590481] alpha data-mesher[209]: time=2026-08-31T09:59:25.643Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]286beta # [7209339.588484] beta data-mesher[209]: time=2026-08-31T09:59:25.641Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml287alpha # [7209339.591816] alpha data-mesher[209]: time=2026-08-31T09:59:25.644Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g: [/dns/alpha.clan/tcp/7946]} {12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g288beta # [7209339.723116] beta systemd-logind[228]: New seat seat0.289alpha # [7209339.591816] alpha data-mesher[209]: time=2026-08-31T09:59:25.644Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml290beta # [7209339.723247] beta systemd[1]: Started User Login Management.291alpha # [7209339.712198] alpha systemd-networkd[197]: eth1: Gained IPv6LL292alpha # [7209339.718046] alpha systemd-logind[228]: New seat seat0.293alpha # [7209339.718587] alpha systemd[1]: Started User Login Management.294alpha # [7209339.720315] alpha systemd[1]: Starting linger-users.service...295alpha # [7209339.784430] alpha systemd[1]: linger-users.service: Deactivated successfully.296alpha # [7209339.784611] alpha systemd[1]: Finished linger-users.service.297beta # [7209339.776510] beta systemd[1]: Starting linger-users.service...298beta # [7209339.792773] beta systemd[1]: linger-users.service: Deactivated successfully.299beta # [7209339.792868] beta systemd[1]: Finished linger-users.service.300beta # [7209339.808192] beta systemd-networkd[197]: eth1: Gained IPv6LL301gamma # [7209339.792540] gamma systemd[1]: linger-users.service: Deactivated successfully.302gamma # [7209339.792604] gamma systemd[1]: Finished linger-users.service.303gamma # [7209339.877086] gamma data-mesher[209]: time=2026-08-31T09:59:25.930Z level=INFO msg="checking file integrity"304gamma # [7209339.877231] gamma data-mesher[209]: time=2026-08-31T09:59:25.930Z level=INFO msg="file integrity check complete"305gamma # [7209339.881146] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="libp2p host created" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r 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]"306gamma # [7209339.881181] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=GET path=/files307gamma # [7209339.881201] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name308gamma # [7209339.881201] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name309gamma # [7209339.881201] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="starting server"310gamma # [7209339.881291] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="waiting for DHT to populate" delay=10s311gamma # [7209339.881370] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="HTTP server listening" address=[::1]:7331312gamma # [7209339.881408] gamma data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331313gamma # [7209339.885754] gamma data-mesher[209]: time=2026-08-31T09:59:25.938Z level=INFO msg="peer connected" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 remote_addr=/ip4/192.168.1.2/tcp/7946314gamma # [7209339.890503] gamma data-mesher[209]: time=2026-08-31T09:59:25.943Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip4/192.168.1.1/tcp/7946315gamma # [7209339.894512] gamma data-mesher[209]: time=2026-08-31T09:59:25.947Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip4/192.168.1.1/tcp/50560316beta # [7209339.873081] beta data-mesher[209]: time=2026-08-31T09:59:25.924Z level=INFO msg="checking file integrity"317beta # [7209339.873081] beta data-mesher[209]: time=2026-08-31T09:59:25.924Z level=INFO msg="file integrity check complete"318beta # [7209339.877882] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="libp2p host created" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 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]"319beta # [7209339.877964] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="registered HTTP route" method=GET path=/files320beta # [7209339.877964] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name321beta # [7209339.877964] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name322beta # [7209339.877964] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="starting server"323beta # [7209339.878300] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="waiting for DHT to populate" delay=10s324beta # [7209339.878300] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="HTTP server listening" address=[::1]:7331325beta # [7209339.878300] beta data-mesher[209]: time=2026-08-31T09:59:25.931Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331326beta # [7209339.886257] beta data-mesher[209]: time=2026-08-31T09:59:25.939Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip4/192.168.1.1/tcp/7946327beta # [7209339.886604] beta data-mesher[209]: time=2026-08-31T09:59:25.939Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip4/192.168.1.3/tcp/7946328alpha # [7209339.877082] alpha data-mesher[209]: time=2026-08-31T09:59:25.930Z level=INFO msg="checking file integrity"329alpha # [7209339.877292] alpha data-mesher[209]: time=2026-08-31T09:59:25.930Z level=INFO msg="file integrity check complete"330alpha # [7209339.881292] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="libp2p host created" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g 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]"331alpha # [7209339.881375] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=GET path=/files332alpha # [7209339.881375] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name333alpha # [7209339.881375] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name334alpha # [7209339.881375] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="starting server"335alpha # [7209339.881455] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="waiting for DHT to populate" delay=10s336alpha # [7209339.881529] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="HTTP server listening" address=[::1]:7331337alpha # [7209339.881567] alpha data-mesher[209]: time=2026-08-31T09:59:25.934Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331338alpha # [7209339.885594] alpha data-mesher[209]: time=2026-08-31T09:59:25.938Z level=INFO msg="peer connected" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 remote_addr=/ip4/192.168.1.2/tcp/7946339alpha # [7209339.891206] alpha data-mesher[209]: time=2026-08-31T09:59:25.944Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip4/192.168.1.3/tcp/7946340alpha # [7209339.893440] alpha data-mesher[209]: time=2026-08-31T09:59:25.946Z level=INFO msg="peer connected" peer_id=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r remote_addr=/ip4/192.168.1.3/tcp/7946341beta # [7209340.904708] beta data-mesher[209]: time=2026-08-31T09:59:26.957Z level=INFO msg="peer connected" peer_id=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g remote_addr=/ip6/2001:db8:1::1/tcp/7946342alpha # [7209340.906578] alpha data-mesher[209]: time=2026-08-31T09:59:26.959Z level=INFO msg="peer connected" peer_id=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 remote_addr=/ip6zone/eth1/ip6/fe80::1cc0:15ff:fe0c:cce3/tcp/7946343alpha: still waiting for container 'alpha' to reach ready state...344beta # [7209349.878771] beta data-mesher[209]: time=2026-08-31T09:59:35.931Z level=INFO msg="performing state exchange with peers on join" count=1345beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.931Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s346beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.932Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g347beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.932Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s348beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.932Z level=INFO msg="server started"349beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.933Z level=INFO msg="starting expired-file sweeper" interval=1m0s350beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.934Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r351beta # [7209350.122727] beta data-mesher[209]: time=2026-08-31T09:59:35.934Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r352beta # [7209349.880154] beta systemd[1]: Started data mesher daemon.353beta # [7209349.880662] beta systemd[1]: Reached target Multi-User System.354alpha # [7209349.879525] alpha data-mesher[209]: time=2026-08-31T09:59:35.932Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498355alpha # [7209349.879525] alpha data-mesher[209]: time=2026-08-31T09:59:35.932Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498356alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="performing state exchange with peers on join" count=1357alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.935Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s358alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.936Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r359alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.936Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s360alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.936Z level=INFO msg="server started"361alpha # [7209350.122846] alpha data-mesher[209]: time=2026-08-31T09:59:35.936Z level=INFO msg="starting expired-file sweeper" interval=1m0s362alpha # [7209349.883219] alpha systemd[1]: Started data mesher daemon.363alpha # [7209349.883726] alpha systemd[1]: Reached target Multi-User System.364gamma # [7209349.881355] gamma data-mesher[209]: time=2026-08-31T09:59:35.934Z level=INFO msg="performing state exchange with peers on join" count=1365gamma # [7209349.881355] gamma data-mesher[209]: time=2026-08-31T09:59:35.934Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s366gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498367gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s368gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="server started"369gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="starting expired-file sweeper" interval=1m0s370gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g371gamma # [7209350.122859] gamma data-mesher[209]: time=2026-08-31T09:59:35.935Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g372gamma # [7209349.882525] gamma systemd[1]: Started data mesher daemon.373gamma # [7209349.883033] gamma systemd[1]: Reached target Multi-User System.374beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.933Z level=DEBUG msg="attempting push/pull" peer_count=2375beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.933Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s376beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.934Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r377beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.934Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s378beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.934Z level=DEBUG msg="push/pull successful" interval=5s379beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r380beta # [7209354.884026] beta data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r381gamma # [7209354.880673] gamma data-mesher[209]: time=2026-08-31T09:59:40.933Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498382gamma # [7209354.880673] gamma data-mesher[209]: time=2026-08-31T09:59:40.933Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498383gamma # [7209354.883223] gamma data-mesher[209]: time=2026-08-31T09:59:40.936Z level=DEBUG msg="attempting push/pull" peer_count=2384gamma # [7209354.883534] gamma data-mesher[209]: time=2026-08-31T09:59:40.936Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s385gamma # [7209354.884270] gamma data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498386gamma # [7209354.884316] gamma data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s387gamma # [7209354.884340] gamma data-mesher[209]: time=2026-08-31T09:59:40.937Z level=DEBUG msg="push/pull successful" interval=5s388gamma # [7209354.884600] gamma data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g389gamma # [7209354.884648] gamma data-mesher[209]: time=2026-08-31T09:59:40.937Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g390alpha # [7209354.884142] alpha data-mesher[209]: time=2026-08-31T09:59:40.937Z level=DEBUG msg="attempting push/pull" peer_count=2391alpha # [7209354.884142] alpha data-mesher[209]: time=2026-08-31T09:59:40.937Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s392alpha # [7209354.884957] alpha data-mesher[209]: time=2026-08-31T09:59:40.938Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r393alpha # [7209354.884995] alpha data-mesher[209]: time=2026-08-31T09:59:40.938Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s394alpha # [7209354.885020] alpha data-mesher[209]: time=2026-08-31T09:59:40.938Z level=DEBUG msg="push/pull successful" interval=5s395alpha: still waiting for container 'alpha' to reach ready state...396beta # [7209359.882042] beta data-mesher[209]: time=2026-08-31T09:59:45.935Z level=DEBUG msg="attempting push/pull" peer_count=2397beta # [7209359.882042] beta data-mesher[209]: time=2026-08-31T09:59:45.935Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s398beta # [7209359.882900] beta data-mesher[209]: time=2026-08-31T09:59:45.936Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g399beta # [7209359.882900] beta data-mesher[209]: time=2026-08-31T09:59:45.936Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s400beta # [7209359.882900] beta data-mesher[209]: time=2026-08-31T09:59:45.936Z level=DEBUG msg="push/pull successful" interval=5s401gamma # [7209359.884522] gamma data-mesher[209]: time=2026-08-31T09:59:45.937Z level=DEBUG msg="attempting push/pull" peer_count=2402gamma # [7209359.885298] gamma data-mesher[209]: time=2026-08-31T09:59:45.937Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s403alpha # [7209359.882767] alpha data-mesher[209]: time=2026-08-31T09:59:45.935Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498404gamma # [7209359.885298] gamma data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g405alpha # [7209359.882767] alpha data-mesher[209]: time=2026-08-31T09:59:45.935Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498406gamma # [7209359.885298] gamma data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s407alpha # [7209359.885061] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r408gamma # [7209359.885298] gamma data-mesher[209]: time=2026-08-31T09:59:45.938Z level=DEBUG msg="push/pull successful" interval=5s409alpha # [7209359.885061] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r410alpha # [7209359.885212] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=DEBUG msg="attempting push/pull" peer_count=2411alpha # [7209359.885212] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s412alpha # [7209359.885676] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r413alpha # [7209359.885676] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s414alpha # [7209359.885788] alpha data-mesher[209]: time=2026-08-31T09:59:45.938Z level=DEBUG msg="push/pull successful" interval=5s415gamma # [7209359.885509] gamma data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g416gamma # [7209359.885509] gamma data-mesher[209]: time=2026-08-31T09:59:45.938Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g417beta # [7209364.883528] beta data-mesher[209]: time=2026-08-31T09:59:50.936Z level=DEBUG msg="attempting push/pull" peer_count=2418beta # [7209364.883528] beta data-mesher[209]: time=2026-08-31T09:59:50.936Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s419beta # [7209364.884133] beta data-mesher[209]: time=2026-08-31T09:59:50.937Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r420beta # [7209364.884133] beta data-mesher[209]: time=2026-08-31T09:59:50.937Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s421beta # [7209364.884274] beta data-mesher[209]: time=2026-08-31T09:59:50.937Z level=DEBUG msg="push/pull successful" interval=5s422beta # [7209364.887109] beta data-mesher[209]: time=2026-08-31T09:59:50.940Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r423beta # [7209364.887109] beta data-mesher[209]: time=2026-08-31T09:59:50.940Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r424gamma # [7209364.885773] gamma data-mesher[209]: time=2026-08-31T09:59:50.937Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498425gamma # [7209364.885773] gamma data-mesher[209]: time=2026-08-31T09:59:50.937Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498426gamma # [7209364.886690] gamma data-mesher[209]: time=2026-08-31T09:59:50.939Z level=DEBUG msg="attempting push/pull" peer_count=2427gamma # [7209364.886725] gamma data-mesher[209]: time=2026-08-31T09:59:50.939Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s428gamma # [7209364.887738] gamma data-mesher[209]: time=2026-08-31T09:59:50.940Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g429gamma # [7209364.887738] gamma data-mesher[209]: time=2026-08-31T09:59:50.940Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g430gamma # [7209364.887891] gamma data-mesher[209]: time=2026-08-31T09:59:50.941Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498431gamma # [7209364.887891] gamma data-mesher[209]: time=2026-08-31T09:59:50.941Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s432gamma # [7209364.887939] gamma data-mesher[209]: time=2026-08-31T09:59:50.941Z level=DEBUG msg="push/pull successful" interval=5s433alpha # [7209364.886823] alpha data-mesher[209]: time=2026-08-31T09:59:50.939Z level=DEBUG msg="attempting push/pull" peer_count=2434alpha # [7209364.886823] alpha data-mesher[209]: time=2026-08-31T09:59:50.939Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s435alpha # [7209364.888130] alpha data-mesher[209]: time=2026-08-31T09:59:50.941Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r436alpha # [7209364.888130] alpha data-mesher[209]: time=2026-08-31T09:59:50.941Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s437alpha # [7209364.888130] alpha data-mesher[209]: time=2026-08-31T09:59:50.941Z level=DEBUG msg="push/pull successful" interval=5s438alpha: still waiting for container 'alpha' to reach ready state...439alpha: (finished: waiting for unit data-mesher.service, in 31.17 seconds)440beta: waiting for unit data-mesher.service441beta: (finished: waiting for unit data-mesher.service, in 0.02 seconds)442gamma: waiting for unit data-mesher.service443gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds)444alpha: must succeed: echo -n 'hello world' > /tmp/test_file445alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.01 seconds)446alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key447alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.07 seconds)448??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.449 File "/nix/store/pg5lbaicpvf34wrdmfh8riwp8avk7lk6-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39450alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file451??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.452 File "/nix/store/pg5lbaicpvf34wrdmfh8riwp8avk7lk6-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39453alpha: (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.01 seconds)454beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file455gamma # [7209367.682861] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.456gamma # [7209367.684066] gamma systemd[1]: Finished Save Transient machine-id to Disk.457gamma # [7209367.684333] gamma systemd[1]: Startup finished in 30.570s.458alpha # [7209367.684645] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.459alpha # [7209367.686006] alpha systemd[1]: Finished Save Transient machine-id to Disk.460alpha # [7209367.686270] alpha systemd[1]: Startup finished in 30.572s.461alpha # [7209367.845728] alpha data-mesher[209]: time=2026-08-31T09:59:53.898Z level=INFO msg=http_request uri=/files/test_file status=204462beta # [7209367.687579] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.463beta # [7209367.690071] beta systemd[1]: Finished Save Transient machine-id to Disk.464beta # [7209367.690529] beta systemd[1]: Startup finished in 30.574s.465beta # [7209369.884543] beta data-mesher[209]: time=2026-08-31T09:59:55.937Z level=DEBUG msg="attempting push/pull" peer_count=2466beta # [7209369.884543] beta data-mesher[209]: time=2026-08-31T09:59:55.937Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s467beta # [7209369.885440] beta data-mesher[209]: time=2026-08-31T09:59:55.938Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r468beta # [7209369.885440] beta data-mesher[209]: time=2026-08-31T09:59:55.938Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s469beta # [7209369.885440] beta data-mesher[209]: time=2026-08-31T09:59:55.938Z level=DEBUG msg="push/pull successful" interval=5s470beta # [7209369.889090] beta data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r471beta # [7209369.889090] beta data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r472gamma # [7209369.884905] gamma data-mesher[209]: time=2026-08-31T09:59:55.938Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498473gamma # [7209369.884905] gamma data-mesher[209]: time=2026-08-31T09:59:55.938Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498474gamma # [7209369.888930] gamma data-mesher[209]: time=2026-08-31T09:59:55.941Z level=DEBUG msg="attempting push/pull" peer_count=2475gamma # [7209369.888930] gamma data-mesher[209]: time=2026-08-31T09:59:55.941Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s476gamma # [7209369.889275] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498477gamma # [7209369.889275] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s478gamma # [7209369.889382] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=DEBUG msg="push/pull successful" interval=5s479gamma # [7209369.889481] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g480gamma # [7209369.889481] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g481gamma # [7209369.889529] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_file482gamma # [7209369.889593] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="scheduling file download" name=test_file483gamma # [7209369.889627] gamma data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-31 09:59:53.857 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g484gamma # [7209369.916404] gamma data-mesher[209]: time=2026-08-31T09:59:55.969Z level=INFO msg="download complete" name=test_file signed_at="2026-08-31 09:59:53.857 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=26.752693ms485alpha # [7209369.888745] alpha data-mesher[209]: time=2026-08-31T09:59:55.941Z level=DEBUG msg="attempting push/pull" peer_count=2486alpha # [7209369.888745] alpha data-mesher[209]: time=2026-08-31T09:59:55.941Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s487alpha # [7209369.889690] alpha data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r488alpha # [7209369.889690] alpha data-mesher[209]: time=2026-08-31T09:59:55.942Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s489alpha # [7209369.889690] alpha data-mesher[209]: time=2026-08-31T09:59:55.942Z level=DEBUG msg="push/pull successful" interval=5s490alpha # [7209369.890039] alpha data-mesher[209]: time=2026-08-31T09:59:55.943Z level=INFO msg="received file request" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file491alpha # [7209369.891284] alpha data-mesher[209]: time=2026-08-31T09:59:55.944Z level=INFO msg="file transfer complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file492beta: (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 7.05 seconds)493gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file494gamma: (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.01 seconds)495beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key496beta: (finished: waiting for success: data-mesher file delete test_file --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.03 seconds)497alpha: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file498alpha # [7209374.890500] alpha data-mesher[209]: time=2026-08-31T10:00:00.943Z level=DEBUG msg="attempting push/pull" peer_count=2499gamma # [7209374.885835] gamma data-mesher[209]: time=2026-08-31T10:00:00.938Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498500gamma # [7209374.885835] gamma data-mesher[209]: time=2026-08-31T10:00:00.939Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498501beta # [7209374.885380] beta data-mesher[209]: time=2026-08-31T10:00:00.938Z level=DEBUG msg="attempting push/pull" peer_count=2502gamma # [7209374.886864] gamma data-mesher[209]: time=2026-08-31T10:00:00.940Z level=INFO msg="received file request" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file503beta # [7209374.885747] beta data-mesher[209]: time=2026-08-31T10:00:00.938Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s504beta # [7209374.886290] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r505alpha # [7209374.890907] alpha data-mesher[209]: time=2026-08-31T10:00:00.943Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s506beta # [7209374.886328] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=DEBUG msg="new file detected" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r name=test_file name=test_file507gamma # [7209374.887515] gamma data-mesher[209]: time=2026-08-31T10:00:00.940Z level=INFO msg="file transfer complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_file508gamma # [7209374.889907] gamma data-mesher[209]: time=2026-08-31T10:00:00.943Z level=DEBUG msg="attempting push/pull" peer_count=2509alpha # [7209374.891209] alpha data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498510alpha # [7209374.891209] alpha data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s511alpha # [7209374.891278] alpha data-mesher[209]: time=2026-08-31T10:00:00.944Z level=DEBUG msg="push/pull successful" interval=5s512beta # [7209374.886349] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s513gamma # [7209374.889950] gamma data-mesher[209]: time=2026-08-31T10:00:00.943Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s514beta # [7209374.886389] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=INFO msg="scheduling file download" name=test_file515gamma # [7209374.891232] gamma data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498516beta # [7209374.886414] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=DEBUG msg="push/pull successful" interval=5s517gamma # [7209374.891261] gamma data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s518beta # [7209374.886435] beta data-mesher[209]: time=2026-08-31T10:00:00.939Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-31 09:59:53.857 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r519gamma # [7209374.891281] gamma data-mesher[209]: time=2026-08-31T10:00:00.944Z level=DEBUG msg="push/pull successful" interval=5s520beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.943Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r521beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r522beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.944Z level=DEBUG msg="new file detected" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r name=test_file name=test_file523beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g524beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.944Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g525beta # [7209374.891702] beta data-mesher[209]: time=2026-08-31T10:00:00.944Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_file526beta # [7209374.912687] beta data-mesher[209]: time=2026-08-31T10:00:00.965Z level=INFO msg="download complete" name=test_file signed_at="2026-08-31 09:59:53.857 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r written=true elapsed=26.233726ms527beta # [7209374.946795] beta data-mesher[209]: time=2026-08-31T10:00:00.999Z level=INFO msg=http_request uri=/files/test_file status=204528beta # [7209379.886841] beta data-mesher[209]: time=2026-08-31T10:00:05.939Z level=DEBUG msg="attempting push/pull" peer_count=2529beta # [7209379.886841] beta data-mesher[209]: time=2026-08-31T10:00:05.939Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s530beta # [7209379.892709] beta data-mesher[209]: time=2026-08-31T10:00:05.945Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r531beta # [7209379.892767] beta data-mesher[209]: time=2026-08-31T10:00:05.945Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r532beta # [7209379.895550] beta data-mesher[209]: time=2026-08-31T10:00:05.948Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r533beta # [7209379.895586] beta data-mesher[209]: time=2026-08-31T10:00:05.948Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s534beta # [7209379.895611] beta data-mesher[209]: time=2026-08-31T10:00:05.948Z level=DEBUG msg="push/pull successful" interval=5s535gamma # [7209379.887087] gamma data-mesher[209]: time=2026-08-31T10:00:05.940Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498536gamma # [7209379.887087] gamma data-mesher[209]: time=2026-08-31T10:00:05.940Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498537gamma # [7209379.892238] gamma data-mesher[209]: time=2026-08-31T10:00:05.945Z level=DEBUG msg="attempting push/pull" peer_count=2538gamma # [7209379.892238] gamma data-mesher[209]: time=2026-08-31T10:00:05.945Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s539gamma # [7209379.892649] gamma data-mesher[209]: time=2026-08-31T10:00:05.945Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g540alpha # [7209379.892455] alpha data-mesher[209]: time=2026-08-31T10:00:05.945Z level=DEBUG msg="attempting push/pull" peer_count=2541gamma # [7209379.892649] gamma data-mesher[209]: time=2026-08-31T10:00:05.945Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g542gamma # [7209379.892940] gamma data-mesher[209]: time=2026-08-31T10:00:05.946Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498543gamma # [7209379.895088] gamma data-mesher[209]: time=2026-08-31T10:00:05.948Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=true544gamma # [7209379.895301] gamma data-mesher[209]: time=2026-08-31T10:00:05.948Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=false545gamma # [7209379.895301] gamma data-mesher[209]: time=2026-08-31T10:00:05.948Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s546gamma # [7209379.895504] gamma data-mesher[209]: time=2026-08-31T10:00:05.948Z level=DEBUG msg="push/pull successful" interval=5s547alpha # [7209379.892455] alpha data-mesher[209]: time=2026-08-31T10:00:05.945Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s548alpha # [7209379.892993] alpha data-mesher[209]: time=2026-08-31T10:00:05.946Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r549alpha # [7209379.892993] alpha data-mesher[209]: time=2026-08-31T10:00:05.946Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s550alpha # [7209379.893048] alpha data-mesher[209]: time=2026-08-31T10:00:05.946Z level=DEBUG msg="push/pull successful" interval=5s551alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 10.07 seconds)552beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file553beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)554gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file555gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)556alpha: must succeed: cat /nix/store/sqi97m2l87iwib6dv6y6p010s37vklzv-per-machine-alpha-data-mesher-node-identity_identity.pub557alpha: (finished: must succeed: cat /nix/store/sqi97m2l87iwib6dv6y6p010s37vklzv-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds)558alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file559alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.00 seconds)560alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert561alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.02 seconds)562alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s563alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 0.01 seconds)564beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s565gamma # [7209384.896410] gamma data-mesher[209]: time=2026-08-31T10:00:10.949Z level=DEBUG msg="attempting push/pull" peer_count=2566gamma # [7209384.896804] gamma data-mesher[209]: time=2026-08-31T10:00:10.949Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s567gamma # [7209384.897411] gamma data-mesher[209]: time=2026-08-31T10:00:10.950Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498568gamma # [7209384.897411] gamma data-mesher[209]: time=2026-08-31T10:00:10.950Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s569gamma # [7209384.897411] gamma data-mesher[209]: time=2026-08-31T10:00:10.950Z level=DEBUG msg="push/pull successful" interval=5s570alpha # [7209384.893572] alpha data-mesher[209]: time=2026-08-31T10:00:10.946Z level=DEBUG msg="attempting push/pull" peer_count=2571alpha # [7209384.893572] alpha data-mesher[209]: time=2026-08-31T10:00:10.946Z level=DEBUG msg="initiating state exchange" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s572beta # [7209384.893889] beta data-mesher[209]: time=2026-08-31T10:00:10.947Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g573alpha # [7209384.894976] alpha data-mesher[209]: time=2026-08-31T10:00:10.947Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498574alpha # [7209384.896217] alpha data-mesher[209]: time=2026-08-31T10:00:10.949Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498575alpha # [7209384.896217] alpha data-mesher[209]: time=2026-08-31T10:00:10.949Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498576alpha # [7209384.928654] alpha data-mesher[209]: time=2026-08-31T10:00:10.981Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=true577alpha # [7209384.928654] alpha data-mesher[209]: time=2026-08-31T10:00:10.981Z level=INFO msg="state exchange complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 timeout=5s578alpha # [7209384.928780] alpha data-mesher[209]: time=2026-08-31T10:00:10.981Z level=DEBUG msg="push/pull successful" interval=5s579alpha # [7209384.928780] alpha data-mesher[209]: time=2026-08-31T10:00:10.981Z level=DEBUG msg="imported tombstone" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 name=test_file written=false580alpha # [7209385.060857] alpha data-mesher[209]: time=2026-08-31T10:00:11.113Z level=INFO msg=http_request uri=/files/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s status=204581beta # [7209384.893889] beta data-mesher[209]: time=2026-08-31T10:00:10.947Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g582beta # [7209384.896074] beta data-mesher[209]: time=2026-08-31T10:00:10.948Z level=DEBUG msg="attempting push/pull" peer_count=2583beta # [7209384.896074] beta data-mesher[209]: time=2026-08-31T10:00:10.949Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s584beta # [7209384.896875] beta data-mesher[209]: time=2026-08-31T10:00:10.949Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r585beta # [7209384.896875] beta data-mesher[209]: time=2026-08-31T10:00:10.949Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r586beta # [7209384.929153] beta data-mesher[209]: time=2026-08-31T10:00:10.982Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g587beta # [7209384.929153] beta data-mesher[209]: time=2026-08-31T10:00:10.982Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s588beta # [7209384.929251] beta data-mesher[209]: time=2026-08-31T10:00:10.982Z level=DEBUG msg="push/pull successful" interval=5s589beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 5.04 seconds)590gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s591gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s, in 0.01 seconds)592alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert593alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.01 seconds)594alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub595alpha # [7209389.898575] alpha data-mesher[209]: time=2026-08-31T10:00:15.951Z level=INFO msg="received state sync from peer" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r596alpha # [7209389.898575] alpha data-mesher[209]: time=2026-08-31T10:00:15.951Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r597alpha # [7209389.900907] alpha data-mesher[209]: time=2026-08-31T10:00:15.954Z level=INFO msg="received file request" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s598Error: failed to update file: 403 Forbidden, signer sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s= is not authorized for this file test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s599alpha # [7209389.901205] alpha data-mesher[209]: time=2026-08-31T10:00:15.954Z level=INFO msg="file transfer complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s600alpha # [7209389.929409] alpha data-mesher[209]: time=2026-08-31T10:00:15.982Z level=DEBUG msg="attempting push/pull" peer_count=2601alpha # [7209389.929409] alpha data-mesher[209]: time=2026-08-31T10:00:15.982Z level=DEBUG msg="initiating state exchange" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s602alpha # [7209389.931296] alpha data-mesher[209]: time=2026-08-31T10:00:15.984Z level=INFO msg="merging remote state" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r603alpha # [7209389.931416] alpha data-mesher[209]: time=2026-08-31T10:00:15.984Z level=INFO msg="received state sync from peer" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498604alpha # [7209389.931450] alpha data-mesher[209]: time=2026-08-31T10:00:15.984Z level=INFO msg="merging remote state" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498605alpha # [7209389.931517] alpha data-mesher[209]: time=2026-08-31T10:00:15.984Z level=INFO msg="state exchange complete" peer=12D3KooWP9dVC44FsZsB8XvQQmksu88gdTFtJDeSJXtcwGxhGX1r timeout=5s606alpha # [7209389.931584] alpha data-mesher[209]: time=2026-08-31T10:00:15.984Z level=DEBUG msg="push/pull successful" interval=5s607alpha # [7209389.932561] alpha data-mesher[209]: time=2026-08-31T10:00:15.985Z level=INFO msg="received file request" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s608alpha # [7209389.951968] alpha data-mesher[209]: time=2026-08-31T10:00:16.005Z level=INFO msg="file transfer complete" peer=12D3KooWJPgbQSHBJXzprM8vMGqzzZUZVUdz3QrrmSvNQbhhw498 network="LM5F3CCzT2YND1DwDVftwpbkgEhwBAj72G9m07r/w0M=" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s609alpha # [7209390.158805] alpha data-mesher[209]: time=2026-08-31T10:00:16.211Z level=INFO msg=http_request uri=/files/test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s status=403610alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/32vjikavq9qsb0q34yz8gx86543d6j39-shared-data-mesher-network_network.pub, in 0.04 seconds)611(finished: run the VM test script, in 53.60 seconds)612test script finished in 53.64s613cleanup614kill NspawnMachine (pid 52)615gamma # [7209389.899334] gamma data-mesher[209]: time=2026-08-31T10:00:15.950Z level=DEBUG msg="attempting push/pull" peer_count=2616gamma # [7209389.899334] gamma data-mesher[209]: time=2026-08-31T10:00:15.951Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s617gamma # [7209389.899334] gamma data-mesher[209]: time=2026-08-31T10:00:15.952Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g618gamma # [7209389.899804] gamma data-mesher[209]: time=2026-08-31T10:00:15.952Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s619gamma # [7209389.899830] gamma data-mesher[209]: time=2026-08-31T10:00:15.952Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s620gamma # [7209389.900155] gamma data-mesher[209]: time=2026-08-31T10:00:15.953Z level=DEBUG msg="push/pull successful" interval=5s621gamma # [7209389.900155] gamma data-mesher[209]: time=2026-08-31T10:00:15.953Z level=INFO msg="scheduling file download" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s622gamma # [7209389.904033] gamma data-mesher[209]: time=2026-08-31T10:00:15.953Z level=INFO msg="downloading file" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 10:00:11.112 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g623gamma # [7209389.904033] gamma data-mesher[209]: time=2026-08-31T10:00:15.956Z level=INFO msg="download complete" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 10:00:11.112 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=3.59533ms624gamma # [7209389.930228] gamma data-mesher[209]: time=2026-08-31T10:00:15.983Z level=INFO msg="received state sync from peer" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g625gamma # [7209389.930228] gamma data-mesher[209]: time=2026-08-31T10:00:15.983Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g626kill NspawnMachine (pid 55)627beta # [7209389.930108] beta data-mesher[209]: time=2026-08-31T10:00:15.983Z level=DEBUG msg="attempting push/pull" peer_count=2628beta # [7209389.930502] beta data-mesher[209]: time=2026-08-31T10:00:15.983Z level=DEBUG msg="initiating state exchange" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s629beta # [7209389.931726] beta data-mesher[209]: time=2026-08-31T10:00:15.984Z level=INFO msg="merging remote state" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g630beta # [7209389.931964] beta data-mesher[209]: time=2026-08-31T10:00:15.985Z level=DEBUG msg="new file detected" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g name=test_file name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s631beta # [7209389.932050] beta data-mesher[209]: time=2026-08-31T10:00:15.985Z level=INFO msg="state exchange complete" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g timeout=5s632beta # [7209389.932078] beta data-mesher[209]: time=2026-08-31T10:00:15.985Z level=DEBUG msg="push/pull successful" interval=5s633beta # [7209389.932143] beta data-mesher[209]: time=2026-08-31T10:00:15.985Z level=INFO msg="scheduling file download" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s634beta # [7209389.932178] beta data-mesher[209]: time=2026-08-31T10:00:15.985Z level=INFO msg="downloading file" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 10:00:11.112 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g635beta # [7209389.958472] beta data-mesher[209]: time=2026-08-31T10:00:16.011Z level=INFO msg="download complete" name=test_ns/sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s signed_at="2026-08-31 10:00:11.112 +0000 UTC" signed_by="sTyE74kWzJY4LfEoHmpsNPxlsxmELEVWAjkiBP50T9s=" peer=12D3KooWMkDrY3UBbiEF3ZL4kTar9ZxEh2SSpsWtCoLEBBoYYX3g written=true elapsed=26.272006ms636Container alpha terminated by signal KILL.637kill NspawnMachine (pid 58)638beta # [7209390.374104] beta systemd-networkd[197]: eth1: Link DOWN639Container beta terminated by signal KILL.640(finished: cleanup, in 0.75 seconds)641Container gamma terminated by signal KILL.