container-test-run-data-mesher log

succeeded `container-test-run-data-mesher` `checks.aarch64-linux.data-mesher` · build #464 · 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 53)13alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal...14beta: systemd-nspawn running (pid 54)15gamma: systemd-nspawn running (pid 56)16gamma: Waiting for journal at /build/vm-state-gamma/var/log/journal...17beta: Waiting for journal at /build/vm-state-beta/var/log/journal...18(finished: start all VMs, in 0.00 seconds)19alpha: waiting for unit data-mesher.service20nixos-nspawn(beta): TAP vde-tap1 not found; container will be isolated from VDE21nixos-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.22nixos-nspawn(gamma): TAP vde-tap1 not found; container will be isolated from VDE23nixos-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.24nixos-nspawn(alpha): TAP vde-tap1 not found; container will be isolated from VDE25nixos-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.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 beta on /build/vm-state-beta.31░ Spawning container alpha on /build/vm-state-alpha.32alpha # [6518471.261082] alpha systemd-journald[88]: Journal started33alpha # [6518471.261142] alpha systemd-journald[88]: Runtime Journal (/run/log/journal/701ed93ce9374eeca00f1d87c0ede7bd) is 8M, max 2.5G, 2.4G free.34alpha # [6518471.265716] alpha systemd[1]: Finished Create Static Device Nodes in /dev gracefully.35alpha # [6518471.274130] alpha systemd[1]: Starting Flush Journal to Persistent Storage...36alpha # [6518471.275038] alpha systemd[1]: Starting Network Name Resolution...37alpha # [6518471.275757] alpha systemd[1]: Starting Create Static Device Nodes in /dev...38alpha # [6518471.285253] alpha systemd-journald[88]: Time spent on flushing to /var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd is 984us for 6 entries.39alpha # [6518471.285253] alpha systemd-journald[88]: System Journal (/var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd) is 8M, max 4G, 3.9G free.40alpha # [6518471.291074] alpha systemd[1]: Finished Create Static Device Nodes in /dev.41alpha # [6518471.291346] alpha systemd[1]: Reached target Preparation for Local File Systems.42alpha # [6518471.291450] alpha systemd[1]: Reached target Local File Systems.43alpha # [6518471.292321] alpha systemd[1]: Listening on Boot Loader Control Service Socket.44alpha # [6518471.292368] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container45alpha # [6518471.293311] alpha systemd[1]: Starting Save Transient machine-id to Disk...46alpha # [6518471.293350] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys47alpha # [6518471.318736] alpha systemd[1]: Finished Flush Journal to Persistent Storage.48alpha # [6518471.320112] alpha systemd[1]: Starting Create System Files and Directories...49alpha # [6518471.338023] alpha systemd-tmpfiles[140]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted50alpha # [6518471.338219] alpha systemd-tmpfiles[140]: fchmod() of /var/log/journal failed: Operation not permitted51alpha # [6518471.338359] alpha systemd-tmpfiles[140]: fchmod() of /var/log/journal/701ed93ce9374eeca00f1d87c0ede7bd failed: Operation not permitted52alpha # [6518471.338570] alpha systemd-tmpfiles[140]: fchmod() of /run/log/journal failed: Operation not permitted53alpha # [6518471.340299] alpha systemd[1]: Finished Create System Files and Directories.54alpha # [6518471.341374] alpha systemd[1]: Starting Rebuild Journal Catalog...55alpha # [6518471.342134] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...56alpha # [6518471.352834] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.57alpha # [6518471.360034] alpha systemd[1]: Finished Rebuild Journal Catalog.58alpha # [6518471.361783] alpha systemd[1]: Starting Update is Completed...59gamma # [6518471.262464] gamma systemd-journald[87]: Journal started60gamma # [6518471.262542] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/b2d09d8534914725a22da20908e3cd36) is 8M, max 2.5G, 2.4G free.61gamma # [6518471.272125] gamma systemd[1]: Finished Create Static Device Nodes in /dev gracefully.62gamma # [6518471.282953] gamma systemd[1]: Starting Flush Journal to Persistent Storage...63beta # [6518471.275492] beta systemd-journald[87]: Journal started64gamma # [6518471.283830] gamma systemd[1]: Starting Network Name Resolution...65beta # [6518471.275551] beta systemd-journald[87]: Runtime Journal (/run/log/journal/3f87c3cba01b47b8b4784846f77c0336) is 8M, max 2.5G, 2.4G free.66gamma # [6518471.284583] gamma systemd[1]: Starting Create Static Device Nodes in /dev...67beta # [6518471.282770] beta systemd[1]: Starting Flush Journal to Persistent Storage...68gamma # [6518471.291720] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/b2d09d8534914725a22da20908e3cd36 is 1ms for 6 entries.69beta # [6518471.283728] beta systemd[1]: Starting Network Name Resolution...70gamma # [6518471.291720] gamma systemd-journald[87]: System Journal (/var/log/journal/b2d09d8534914725a22da20908e3cd36) is 8M, max 4G, 3.9G free.71beta # [6518471.285233] beta systemd[1]: Starting Create Static Device Nodes in /dev...72gamma # [6518471.300420] gamma systemd[1]: Finished Create Static Device Nodes in /dev.73beta # [6518471.291890] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/3f87c3cba01b47b8b4784846f77c0336 is 942us for 5 entries.74gamma # [6518471.301035] gamma systemd[1]: Reached target Preparation for Local File Systems.75beta # [6518471.291890] beta systemd-journald[87]: System Journal (/var/log/journal/3f87c3cba01b47b8b4784846f77c0336) is 8M, max 4G, 3.9G free.76gamma # [6518471.301142] gamma systemd[1]: Reached target Local File Systems.77beta # [6518471.300746] beta systemd[1]: Finished Create Static Device Nodes in /dev.78gamma # [6518471.301958] gamma systemd[1]: Listening on Boot Loader Control Service Socket.79beta # [6518471.301315] beta systemd[1]: Reached target Preparation for Local File Systems.80gamma # [6518471.302001] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container81beta # [6518471.301419] beta systemd[1]: Reached target Local File Systems.82gamma # [6518471.302814] gamma systemd[1]: Starting Save Transient machine-id to Disk...83beta # [6518471.302197] beta systemd[1]: Listening on Boot Loader Control Service Socket.84gamma # [6518471.302849] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys85gamma # [6518471.317989] gamma systemd[1]: Finished Flush Journal to Persistent Storage.86gamma # [6518471.319751] gamma systemd[1]: Starting Create System Files and Directories...87beta # [6518471.302238] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container88gamma # [6518471.335213] gamma systemd-tmpfiles[137]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted89beta # [6518471.303177] beta systemd[1]: Starting Save Transient machine-id to Disk...90gamma # [6518471.335382] gamma systemd-tmpfiles[137]: fchmod() of /var/log/journal failed: Operation not permitted91beta # [6518471.303211] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys92gamma # [6518471.335493] gamma systemd-tmpfiles[137]: fchmod() of /var/log/journal/b2d09d8534914725a22da20908e3cd36 failed: Operation not permitted93beta # [6518471.318736] beta systemd[1]: Finished Flush Journal to Persistent Storage.94gamma # [6518471.335662] gamma systemd-tmpfiles[137]: fchmod() of /run/log/journal failed: Operation not permitted95beta # [6518471.320074] beta systemd[1]: Starting Create System Files and Directories...96gamma # [6518471.337288] gamma systemd[1]: Finished Create System Files and Directories.97beta # [6518471.334923] beta systemd-tmpfiles[135]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted98gamma # [6518471.338308] gamma systemd[1]: Starting Rebuild Journal Catalog...99beta # [6518471.335098] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal failed: Operation not permitted100gamma # [6518471.339014] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...101beta # [6518471.335219] beta systemd-tmpfiles[135]: fchmod() of /var/log/journal/3f87c3cba01b47b8b4784846f77c0336 failed: Operation not permitted102gamma # [6518471.352836] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.103beta # [6518471.335402] beta systemd-tmpfiles[135]: fchmod() of /run/log/journal failed: Operation not permitted104gamma # [6518471.356342] gamma systemd[1]: Finished Rebuild Journal Catalog.105beta # [6518471.336680] beta systemd[1]: Finished Create System Files and Directories.106gamma # [6518471.357803] gamma systemd[1]: Starting Update is Completed...107beta # [6518471.337758] beta systemd[1]: Starting Rebuild Journal Catalog...108gamma # [6518471.368023] gamma systemd[1]: Finished Update is Completed.109beta # [6518471.338593] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...110beta # [6518471.349988] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.111beta # [6518471.362720] beta systemd[1]: Finished Rebuild Journal Catalog.112beta # [6518471.363753] beta systemd[1]: Starting Update is Completed...113alpha # [6518471.373545] alpha systemd[1]: Finished Update is Completed.114alpha # [6518471.421312] alpha systemd[1]: Finished Firewall.115alpha # [6518471.421703] alpha systemd[1]: Reached target Preparation for Network.116alpha # [6518471.422000] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.117alpha # [6518471.423205] alpha systemd[1]: Starting Network Management...118gamma # [6518471.421962] gamma systemd[1]: Finished Firewall.119gamma # [6518471.422102] gamma systemd[1]: Reached target Preparation for Network.120gamma # [6518471.422312] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.121gamma # [6518471.423341] gamma systemd[1]: Starting Network Management...122beta # [6518471.373254] beta systemd[1]: Finished Update is Completed.123beta # [6518471.422973] beta systemd[1]: Finished Firewall.124beta # [6518471.423121] beta systemd[1]: Reached target Preparation for Network.125beta # [6518471.423334] beta systemd[1]: Listening on Network Management Resolve Hook Socket.126beta # [6518471.424343] beta systemd[1]: Starting Network Management...127beta # [6518471.818437] beta systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted128beta # [6518471.818533] beta systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted129beta # [6518471.825471] beta systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.130beta # [6518471.825636] beta systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.131beta # [6518471.825792] beta systemd-networkd[204]: lo: Link UP132beta # [6518471.825795] beta systemd-networkd[204]: lo: Gained carrier133beta # [6518471.825990] beta systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.134beta # [6518471.826381] beta systemd[1]: Started Network Management.135beta # [6518471.826457] beta systemd-networkd[204]: eth1: Link UP136beta # [6518471.826740] beta systemd-networkd[204]: eth1: Gained carrier137beta # [6518471.827572] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...138beta # [6518471.913964] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.139beta # [6518471.929933] beta systemd-resolved[108]: Positive Trust Anchors:140beta # [6518471.929943] beta systemd-resolved[108]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d141beta # [6518471.929947] beta systemd-resolved[108]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16142beta # [6518471.929983] beta systemd-resolved[108]: 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 test143beta # [6518471.952559] beta systemd-resolved[108]: Using system hostname 'beta'.144beta # [6518471.953869] beta systemd[1]: Started Network Name Resolution.145beta # [6518471.953947] beta systemd[1]: Reached target Network.146beta # [6518471.954012] beta systemd[1]: Reached target System Initialization.147beta # [6518471.954056] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container148beta # [6518471.954078] beta systemd[1]: Started Daily Cleanup of Temporary Directories.149beta # [6518471.954095] beta systemd[1]: Reached target Timer Units.150beta # [6518471.954211] beta systemd[1]: Listening on D-Bus System Message Bus Socket.151beta # [6518471.954313] beta systemd[1]: Listening on Nix Daemon Socket.152beta # [6518471.954422] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.153beta # [6518471.954449] beta systemd[1]: Reached target Socket Units.154beta # [6518471.954487] beta systemd[1]: Reached target Basic System.155beta # [6518471.955613] beta systemd[1]: Starting data mesher daemon...156beta # [6518471.956291] beta systemd[1]: Starting Import lastlog data into lastlog2 database...157beta # [6518471.996334] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...158beta # [6518471.997934] beta systemd[1]: Starting D-Bus System Message Bus...159beta # [6518472.011172] beta systemd[1]: Finished Import lastlog data into lastlog2 database.160beta # [6518472.079558] beta systemd[1]: Finished Save Transient machine-id to Disk.161alpha # [6518471.833077] alpha systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted162alpha # [6518471.833165] alpha systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted163alpha # [6518471.839811] alpha systemd-networkd[205]: /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.164alpha # [6518471.839974] alpha systemd-networkd[205]: /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.165alpha # [6518471.840134] alpha systemd-networkd[205]: lo: Link UP166alpha # [6518471.840139] alpha systemd-networkd[205]: lo: Gained carrier167alpha # [6518471.840338] alpha systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network.168alpha # [6518471.840722] alpha systemd[1]: Started Network Management.169alpha # [6518471.840792] alpha systemd-networkd[205]: eth1: Link UP170alpha # [6518471.841007] alpha systemd-networkd[205]: eth1: Gained carrier171alpha # [6518471.841852] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...172alpha # [6518471.925926] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.173alpha # [6518471.941679] alpha systemd-resolved[110]: Positive Trust Anchors:174alpha # [6518471.941689] alpha systemd-resolved[110]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d175alpha # [6518471.941693] alpha systemd-resolved[110]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16176alpha # [6518471.941728] alpha systemd-resolved[110]: 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 test177alpha # [6518471.963484] alpha systemd-resolved[110]: Using system hostname 'alpha'.178alpha # [6518471.964801] alpha systemd[1]: Started Network Name Resolution.179alpha # [6518471.964876] alpha systemd[1]: Reached target Network.180alpha # [6518471.964939] alpha systemd[1]: Reached target System Initialization.181alpha # [6518471.964986] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container182alpha # [6518471.965011] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.183alpha # [6518471.965027] alpha systemd[1]: Reached target Timer Units.184alpha # [6518471.965147] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.185alpha # [6518471.965263] alpha systemd[1]: Listening on Nix Daemon Socket.186alpha # [6518471.965373] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.187alpha # [6518471.965393] alpha systemd[1]: Reached target Socket Units.188alpha # [6518471.965432] alpha systemd[1]: Reached target Basic System.189alpha # [6518471.996552] alpha systemd[1]: Starting data mesher daemon...190alpha # [6518471.997777] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...191alpha # [6518471.998666] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...192alpha # [6518471.999922] alpha systemd[1]: Starting D-Bus System Message Bus...193alpha # [6518472.015448] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.194alpha # [6518472.081305] alpha systemd[1]: Finished Save Transient machine-id to Disk.195alpha # [6518472.117077] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).196alpha # [6518472.117140] alpha systemd[1]: Reached target Host and Network Name Lookups.197alpha # [6518472.117200] alpha systemd[1]: Reached target User and Group Name Lookups.198alpha # [6518472.117357] alpha nsncd[212]: Aug 23 10:04:58.170 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"199gamma # [6518471.828982] gamma systemd-networkd[204]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted200gamma # [6518471.829073] gamma systemd-networkd[204]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted201gamma # [6518471.835715] gamma systemd-networkd[204]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.202gamma # [6518471.835881] gamma systemd-networkd[204]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.203gamma # [6518471.836048] gamma systemd-networkd[204]: lo: Link UP204gamma # [6518471.836052] gamma systemd-networkd[204]: lo: Gained carrier205gamma # [6518471.836226] gamma systemd-networkd[204]: eth1: Configuring with /etc/systemd/network/40-eth1.network.206gamma # [6518471.836620] gamma systemd[1]: Started Network Management.207gamma # [6518471.836695] gamma systemd-networkd[204]: eth1: Link UP208gamma # [6518471.836908] gamma systemd-networkd[204]: eth1: Gained carrier209gamma # [6518471.837625] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...210gamma # [6518471.927501] gamma systemd-resolved[111]: Positive Trust Anchors:211gamma # [6518471.927512] gamma systemd-resolved[111]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d212gamma # [6518471.927515] gamma systemd-resolved[111]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16213gamma # [6518471.927551] gamma systemd-resolved[111]: 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 test214gamma # [6518471.929815] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.215gamma # [6518471.949752] gamma systemd-resolved[111]: Using system hostname 'gamma'.216gamma # [6518471.951109] gamma systemd[1]: Started Network Name Resolution.217gamma # [6518471.951183] gamma systemd[1]: Reached target Network.218gamma # [6518471.951252] gamma systemd[1]: Reached target System Initialization.219gamma # [6518471.951299] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container220gamma # [6518471.951326] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.221gamma # [6518471.951342] gamma systemd[1]: Reached target Timer Units.222gamma # [6518471.951459] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.223gamma # [6518471.951577] gamma systemd[1]: Listening on Nix Daemon Socket.224gamma # [6518471.951673] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.225gamma # [6518471.951695] gamma systemd[1]: Reached target Socket Units.226gamma # [6518471.951732] gamma systemd[1]: Reached target Basic System.227gamma # [6518471.952946] gamma systemd[1]: Starting data mesher daemon...228gamma # [6518471.953785] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...229gamma # [6518471.954528] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...230gamma # [6518471.955636] gamma systemd[1]: Starting D-Bus System Message Bus...231gamma # [6518472.011626] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.232gamma # [6518472.077345] gamma systemd[1]: Finished Save Transient machine-id to Disk.233gamma # [6518472.118105] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).234gamma # [6518472.118163] gamma systemd[1]: Reached target Host and Network Name Lookups.235gamma # [6518472.118218] gamma systemd[1]: Reached target User and Group Name Lookups.236gamma # [6518472.118652] gamma nsncd[211]: Aug 23 10:04:58.171 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"237gamma # [6518472.119504] gamma systemd[1]: Starting User Login Management...238gamma # [6518472.120233] gamma systemd[1]: Starting Permit User Sessions...239gamma # [6518472.173449] gamma systemd[1]: Finished Permit User Sessions.240gamma # [6518472.174532] gamma systemd[1]: Started Console Getty.241gamma # [6518472.174578] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0242gamma # [6518472.174593] gamma systemd[1]: Reached target Login Prompts.243gamma # [6518472.207325] gamma dbus-broker-launch[212]: Looking up NSS user entry for 'systemd-timesync'...244gamma # [6518472.208013] gamma dbus-broker-launch[212]: NSS returned no entry for 'systemd-timesync'245gamma # [6518472.208013] gamma dbus-broker-launch[212]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"246gamma # [6518472.208437] gamma systemd[1]: Started D-Bus System Message Bus.247gamma # [6518472.215124] gamma dbus-broker-launch[212]: Ready248gamma # [6518472.251628] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.249beta # [6518472.117582] beta nsncd[211]: Aug 23 10:04:58.170 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"250beta # [6518472.117640] beta systemd[1]: Started Name Service Cache Daemon (nsncd).251beta # [6518472.117697] beta systemd[1]: Reached target Host and Network Name Lookups.252beta # [6518472.117748] beta systemd[1]: Reached target User and Group Name Lookups.253beta # [6518472.118768] beta systemd[1]: Starting User Login Management...254beta # [6518472.119423] beta systemd[1]: Starting Permit User Sessions...255alpha # [6518472.118367] alpha systemd[1]: Starting User Login Management...256beta # [6518472.172990] beta systemd[1]: Finished Permit User Sessions.257alpha # [6518472.119685] alpha systemd[1]: Starting Permit User Sessions...258beta # [6518472.173955] beta systemd[1]: Started Console Getty.259alpha # [6518472.171322] alpha systemd[1]: Finished Permit User Sessions.260beta # [6518472.173993] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0261alpha # [6518472.172333] alpha systemd[1]: Started Console Getty.262beta # [6518472.174014] beta systemd[1]: Reached target Login Prompts.263alpha # [6518472.172374] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0264beta # [6518472.225484] beta dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...265alpha # [6518472.172391] alpha systemd[1]: Reached target Login Prompts.266beta # [6518472.226107] beta dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'267alpha # [6518472.207517] alpha dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...268beta # [6518472.226107] beta dbus-broker-launch[213]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"269alpha # [6518472.208782] alpha dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'270beta # [6518472.226475] beta systemd[1]: Started D-Bus System Message Bus.271alpha # [6518472.208782] alpha dbus-broker-launch[213]: Invalid user-name in /nix/store/k50rh6sxisc74iknrsp9ni7ysv6j17qb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"272beta # [6518472.234000] beta dbus-broker-launch[213]: Ready273alpha # [6518472.209143] alpha systemd[1]: Started D-Bus System Message Bus.274beta # [6518472.262205] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.275alpha # [6518472.216205] alpha dbus-broker-launch[213]: Ready276alpha # [6518472.251610] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.277beta # [6518472.465534] beta data-mesher[209]: time=2026-08-23T10:04:58.518Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]278beta # [6518472.466609] beta data-mesher[209]: time=2026-08-23T10:04:58.519Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3279beta # [6518472.466609] beta data-mesher[209]: time=2026-08-23T10:04:58.519Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml280beta # [6518472.478124] beta data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity"281beta # [6518472.478230] beta data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete"282beta # [6518472.482108] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 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]"283beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files284beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name285beta # [6518472.482145] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name286beta # [6518472.482199] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server"287beta # [6518472.482237] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s288beta # [6518472.482335] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331289beta # [6518472.482370] beta data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331290beta # [6518472.486741] beta data-mesher[209]: time=2026-08-23T10:04:58.539Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946291beta # [6518472.487983] beta data-mesher[209]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946292beta # [6518472.489259] beta data-mesher[209]: time=2026-08-23T10:04:58.542Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946293beta # [6518472.626605] beta systemd-logind[229]: New seat seat0.294beta # [6518472.627110] beta systemd[1]: Started User Login Management.295beta # [6518472.629116] beta systemd[1]: Starting linger-users.service...296beta # [6518472.694161] beta systemd[1]: linger-users.service: Deactivated successfully.297beta # [6518472.694418] beta systemd[1]: Finished linger-users.service.298alpha # [6518472.465091] alpha data-mesher[210]: time=2026-08-23T10:04:58.518Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]299alpha # [6518472.466183] alpha data-mesher[210]: time=2026-08-23T10:04:58.519Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6300alpha # [6518472.466183] alpha data-mesher[210]: time=2026-08-23T10:04:58.519Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml301alpha # [6518472.478109] alpha data-mesher[210]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity"302alpha # [6518472.478225] alpha data-mesher[210]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete"303alpha # [6518472.482088] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 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]"304alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files305alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name306alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name307alpha # [6518472.482162] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server"308alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s309alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331310alpha # [6518472.482342] alpha data-mesher[210]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331311alpha # [6518472.488203] alpha data-mesher[210]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/7946312alpha # [6518472.488203] alpha data-mesher[210]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/39776313alpha # [6518472.494544] alpha data-mesher[210]: time=2026-08-23T10:04:58.547Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946314alpha # [6518472.495284] alpha data-mesher[210]: time=2026-08-23T10:04:58.548Z level=INFO msg="peer connected" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq remote_addr=/ip4/192.168.1.3/tcp/7946315alpha # [6518472.622498] alpha systemd-logind[230]: New seat seat0.316alpha # [6518472.622810] alpha systemd[1]: Started User Login Management.317alpha # [6518472.624618] alpha systemd[1]: Starting linger-users.service...318alpha # [6518472.695982] alpha systemd[1]: linger-users.service: Deactivated successfully.319alpha # [6518472.696133] alpha systemd[1]: Finished linger-users.service.320gamma # [6518472.468037] gamma data-mesher[209]: time=2026-08-23T10:04:58.521Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]321gamma # [6518472.469122] gamma data-mesher[209]: time=2026-08-23T10:04:58.522Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6: [/dns/alpha.clan/tcp/7946]} {12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq322gamma # [6518472.469122] gamma data-mesher[209]: time=2026-08-23T10:04:58.522Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml323gamma # [6518472.478234] gamma data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="checking file integrity"324gamma # [6518472.478341] gamma data-mesher[209]: time=2026-08-23T10:04:58.531Z level=INFO msg="file integrity check complete"325gamma # [6518472.482061] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="libp2p host created" peer_id=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq 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]"326gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name327gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name328gamma # [6518472.482100] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="registered HTTP route" method=GET path=/files329gamma # [6518472.482154] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="starting server"330gamma # [6518472.482203] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="waiting for DHT to populate" delay=10s331gamma # [6518472.482336] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=[::1]:7331332gamma # [6518472.482381] gamma data-mesher[209]: time=2026-08-23T10:04:58.535Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331333gamma # [6518472.488591] gamma data-mesher[209]: time=2026-08-23T10:04:58.541Z level=INFO msg="peer connected" peer_id=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 remote_addr=/ip4/192.168.1.2/tcp/7946334gamma # [6518472.494498] gamma data-mesher[209]: time=2026-08-23T10:04:58.547Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/7946335gamma # [6518472.495479] gamma data-mesher[209]: time=2026-08-23T10:04:58.548Z level=INFO msg="peer connected" peer_id=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 remote_addr=/ip4/192.168.1.1/tcp/54490336gamma # [6518472.648039] gamma systemd-logind[229]: New seat seat0.337gamma # [6518472.648228] gamma systemd[1]: Started User Login Management.338gamma # [6518472.684533] gamma systemd[1]: Starting linger-users.service...339gamma # [6518472.698723] gamma systemd[1]: linger-users.service: Deactivated successfully.340gamma # [6518472.698828] gamma systemd[1]: Finished linger-users.service.341gamma # [6518472.960199] gamma systemd-networkd[204]: eth1: Gained IPv6LL342beta # [6518473.220539] beta systemd-networkd[204]: eth1: Gained IPv6LL343alpha # [6518473.092374] alpha systemd-networkd[205]: eth1: Gained IPv6LL344alpha: still waiting for container 'alpha' to reach ready state...345alpha: (finished: waiting for unit data-mesher.service, in 12.18 seconds)346beta: waiting for unit data-mesher.service347beta: (finished: waiting for unit data-mesher.service, in 0.02 seconds)348gamma: waiting for unit data-mesher.service349gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds)350alpha: must succeed: echo -n 'hello world' > /tmp/test_file351alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.01 seconds)352alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key353alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.04 seconds)354??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.355 File "/nix/store/fbgzqsxpqkgkhszk3qisyi1jhy0lk9g4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39356alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file357??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.358 File "/nix/store/fbgzqsxpqkgkhszk3qisyi1jhy0lk9g4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39359alpha: (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)360beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file361beta # [6518482.482589] beta data-mesher[209]: time=2026-08-23T10:05:08.535Z level=INFO msg="performing state exchange with peers on join" count=1362beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.535Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s363beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6364beta # [6518482.483301] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6365beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6366beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s367beta # [6518482.483457] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="server started"368beta # [6518482.483589] beta data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="starting expired-file sweeper" interval=1m0s369beta # [6518482.483657] beta systemd[1]: Started data mesher daemon.370beta # [6518482.483979] beta systemd[1]: Reached target Multi-User System.371beta # [6518482.484353] beta systemd[1]: Startup finished in 11.591s.372alpha # [6518482.482685] alpha data-mesher[210]: time=2026-08-23T10:05:08.535Z level=INFO msg="performing state exchange with peers on join" count=1373alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.535Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s374alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3375alpha # [6518482.483386] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3376alpha # [6518482.483791] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3377alpha # [6518482.483791] alpha data-mesher[210]: time=2026-08-23T10:05:08.536Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s378alpha # [6518482.483898] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq379alpha # [6518482.483898] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq380alpha # [6518482.483999] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="server started"381alpha # [6518482.484082] alpha data-mesher[210]: time=2026-08-23T10:05:08.537Z level=INFO msg="starting expired-file sweeper" interval=1m0s382alpha # [6518482.484211] alpha systemd[1]: Started data mesher daemon.383alpha # [6518482.484723] alpha systemd[1]: Reached target Multi-User System.384alpha # [6518482.486954] alpha systemd[1]: Startup finished in 11.580s.385alpha # [6518482.618634] alpha data-mesher[210]: time=2026-08-23T10:05:08.671Z level=INFO msg=http_request uri=/files/test_file status=204386gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.536Z level=INFO msg="performing state exchange with peers on join" count=1387gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.536Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s388gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6389gamma # [6518482.484076] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s390gamma # [6518482.484911] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="server started"391gamma # [6518482.484911] gamma data-mesher[209]: time=2026-08-23T10:05:08.537Z level=INFO msg="starting expired-file sweeper" interval=1m0s392gamma # [6518482.484389] gamma systemd[1]: Started data mesher daemon.393gamma # [6518482.484693] gamma systemd[1]: Reached target Multi-User System.394gamma # [6518482.484883] gamma systemd[1]: Startup finished in 11.590s.395beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file, in 5.04 seconds)396gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file397gamma: (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)398beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key399beta: (finished: waiting for success: data-mesher file delete test_file --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.04 seconds)400alpha: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file401beta # [6518487.486281] beta data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2402beta # [6518487.486681] beta data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s403beta # [6518487.487326] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq404beta # [6518487.487367] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq405beta # [6518487.487740] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6406beta # [6518487.487775] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_file407beta # [6518487.487801] beta data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s408beta # [6518487.487841] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=DEBUG msg="push/pull successful" interval=5s409beta # [6518487.487870] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=INFO msg="scheduling file download" name=test_file410beta # [6518487.487925] beta data-mesher[209]: time=2026-08-23T10:05:13.541Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6411beta # [6518487.514284] beta data-mesher[209]: time=2026-08-23T10:05:13.567Z level=INFO msg="download complete" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=26.374364ms412beta # [6518487.724456] beta data-mesher[209]: time=2026-08-23T10:05:13.777Z level=INFO msg=http_request uri=/files/test_file status=204413alpha # [6518487.486410] alpha data-mesher[210]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2414alpha # [6518487.486410] alpha data-mesher[210]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s415alpha # [6518487.487119] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3416alpha # [6518487.487119] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3417alpha # [6518487.487619] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq418alpha # [6518487.487619] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s419alpha # [6518487.487750] alpha data-mesher[210]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="push/pull successful" interval=5s420alpha # [6518487.488191] alpha data-mesher[210]: time=2026-08-23T10:05:13.541Z level=INFO msg="received file request" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file421alpha # [6518487.488327] alpha data-mesher[210]: time=2026-08-23T10:05:13.541Z level=INFO msg="received file request" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file422alpha # [6518487.490039] alpha data-mesher[210]: time=2026-08-23T10:05:13.543Z level=INFO msg="file transfer complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file423alpha # [6518487.490157] alpha data-mesher[210]: time=2026-08-23T10:05:13.543Z level=INFO msg="file transfer complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_file424gamma # [6518487.486792] gamma data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="attempting push/pull" peer_count=2425gamma # [6518487.486792] gamma data-mesher[209]: time=2026-08-23T10:05:13.539Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s426gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6427gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6428gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_file429gamma # [6518487.487487] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="scheduling file download" name=test_file430gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="downloading file" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6431gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3432gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s433gamma # [6518487.487690] gamma data-mesher[209]: time=2026-08-23T10:05:13.540Z level=DEBUG msg="push/pull successful" interval=5s434gamma # [6518487.514351] gamma data-mesher[209]: time=2026-08-23T10:05:13.567Z level=INFO msg="download complete" name=test_file signed_at="2026-08-23 10:05:08.662 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=26.83133ms435alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.04 seconds)436beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file437beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)438gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file439gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)440alpha: must succeed: cat /nix/store/hw6512jcgmq95kz2zrg7yi21w3zia2rx-per-machine-alpha-data-mesher-node-identity_identity.pub441alpha # [6518492.488483] alpha data-mesher[210]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2442gamma # [6518492.488688] gamma data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2443alpha # [6518492.488945] alpha data-mesher[210]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s444gamma # [6518492.488688] gamma data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s445alpha # [6518492.489071] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq446beta # [6518492.488679] beta data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="attempting push/pull" peer_count=2447alpha # [6518492.489071] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq448beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.541Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s449alpha # [6518492.489345] alpha data-mesher[210]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3450beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6451alpha # [6518492.494563] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=DEBUG msg="imported tombstone" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file written=true452beta # [6518492.489229] beta data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6453alpha # [6518492.494563] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s454beta # [6518492.495371] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq455alpha # [6518492.494646] alpha data-mesher[210]: time=2026-08-23T10:05:18.547Z level=DEBUG msg="push/pull successful" interval=5s456beta # [6518492.495489] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s457gamma # [6518492.489170] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3458beta # [6518492.495489] beta data-mesher[209]: time=2026-08-23T10:05:18.548Z level=DEBUG msg="push/pull successful" interval=5s459gamma # [6518492.489170] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3460gamma # [6518492.489629] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6461gamma # [6518492.489672] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s462gamma # [6518492.489731] gamma data-mesher[209]: time=2026-08-23T10:05:18.542Z level=DEBUG msg="push/pull successful" interval=5s463gamma # [6518492.495107] gamma data-mesher[209]: time=2026-08-23T10:05:18.548Z level=DEBUG msg="imported tombstone" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file written=true464alpha: (finished: must succeed: cat /nix/store/hw6512jcgmq95kz2zrg7yi21w3zia2rx-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds)465alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file466alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.01 seconds)467alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert468alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.02 seconds)469alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU470alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 0.01 seconds)471beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU472alpha # [6518492.810637] alpha data-mesher[210]: time=2026-08-23T10:05:18.863Z level=INFO msg=http_request uri=/files/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU status=204473beta # [6518497.492190] beta data-mesher[209]: time=2026-08-23T10:05:23.545Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq474beta # [6518497.493055] beta data-mesher[209]: time=2026-08-23T10:05:23.545Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq475beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=DEBUG msg="attempting push/pull" peer_count=2476beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s477beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6478beta # [6518497.496310] beta data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6479beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU480beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq481beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="scheduling file download" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU482beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s483beta # [6518497.496919] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="push/pull successful" interval=5s484beta # [6518497.497322] beta data-mesher[209]: time=2026-08-23T10:05:23.550Z level=INFO msg="downloading file" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6485beta # [6518497.498963] beta data-mesher[209]: time=2026-08-23T10:05:23.552Z level=INFO msg="download complete" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 written=true elapsed=1.955066ms486gamma # [6518497.490615] gamma data-mesher[209]: time=2026-08-23T10:05:23.543Z level=DEBUG msg="attempting push/pull" peer_count=2487gamma # [6518497.491028] gamma data-mesher[209]: time=2026-08-23T10:05:23.543Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s488gamma # [6518497.493068] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3489gamma # [6518497.493113] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s490gamma # [6518497.493165] gamma data-mesher[209]: time=2026-08-23T10:05:23.546Z level=DEBUG msg="push/pull successful" interval=5s491gamma # [6518497.496678] gamma data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3492gamma # [6518497.496713] gamma data-mesher[209]: time=2026-08-23T10:05:23.549Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3493alpha # [6518497.495560] alpha data-mesher[210]: time=2026-08-23T10:05:23.548Z level=DEBUG msg="attempting push/pull" peer_count=2494alpha # [6518497.495560] alpha data-mesher[210]: time=2026-08-23T10:05:23.548Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s495alpha # [6518497.497179] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3496alpha # [6518497.497257] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s497alpha # [6518497.497257] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=DEBUG msg="push/pull successful" interval=5s498alpha # [6518497.497708] alpha data-mesher[210]: time=2026-08-23T10:05:23.550Z level=INFO msg="received file request" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU499alpha # [6518497.498012] alpha data-mesher[210]: time=2026-08-23T10:05:23.551Z level=INFO msg="file transfer complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU500beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 5.05 seconds)501gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU502beta # [6518502.494840] beta data-mesher[209]: time=2026-08-23T10:05:28.547Z level=INFO msg="received state sync from peer" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq503beta # [6518502.494840] beta data-mesher[209]: time=2026-08-23T10:05:28.548Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq504beta # [6518502.496626] beta data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="received file request" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU505beta # [6518502.497447] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="attempting push/pull" peer_count=2506beta # [6518502.497545] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="initiating state exchange" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s507beta # [6518502.497582] beta data-mesher[209]: time=2026-08-23T10:05:28.550Z level=INFO msg="file transfer complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq network="3D8IZ5fqdOCRn13tTxYeG8VBr7r6G1tsF9xP49h42d0=" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU508beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6509beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="state exchange complete" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 timeout=5s510beta # [6518502.499761] beta data-mesher[209]: time=2026-08-23T10:05:28.552Z level=DEBUG msg="push/pull successful" interval=5s511alpha # [6518502.497517] alpha data-mesher[210]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="attempting push/pull" peer_count=2512alpha # [6518502.497517] alpha data-mesher[210]: time=2026-08-23T10:05:28.550Z level=DEBUG msg="initiating state exchange" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s513alpha # [6518502.498326] alpha data-mesher[210]: time=2026-08-23T10:05:28.551Z level=INFO msg="received state sync from peer" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3514alpha # [6518502.498326] alpha data-mesher[210]: time=2026-08-23T10:05:28.551Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3515alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=INFO msg="merging remote state" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq516alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=INFO msg="state exchange complete" peer=12D3KooWRrumLUuiZwycnutKcspiGc3NWRktjwnEZWYnvwDSk7pq timeout=5s517alpha # [6518502.500032] alpha data-mesher[210]: time=2026-08-23T10:05:28.552Z level=DEBUG msg="push/pull successful" interval=5s518gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU, in 5.04 seconds)519alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert520alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.01 seconds)521alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub522gamma # [6518502.494230] gamma data-mesher[209]: time=2026-08-23T10:05:28.547Z level=DEBUG msg="attempting push/pull" peer_count=2523gamma # [6518502.494751] gamma data-mesher[209]: time=2026-08-23T10:05:28.547Z level=DEBUG msg="initiating state exchange" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s524gamma # [6518502.495238] gamma data-mesher[209]: time=2026-08-23T10:05:28.548Z level=INFO msg="merging remote state" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3525gamma # [6518502.495867] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=DEBUG msg="new file detected" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU526gamma # [6518502.495902] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="state exchange complete" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 timeout=5s527gamma # [6518502.495950] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=DEBUG msg="push/pull successful" interval=5s528gamma # [6518502.495978] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="scheduling file download" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU529gamma # [6518502.496104] gamma data-mesher[209]: time=2026-08-23T10:05:28.549Z level=INFO msg="downloading file" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3530gamma # [6518502.498069] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=INFO msg="received state sync from peer" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6531gamma # [6518502.498094] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=INFO msg="merging remote state" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6532gamma # [6518502.498704] gamma data-mesher[209]: time=2026-08-23T10:05:28.551Z level=DEBUG msg="new file detected" peer=12D3KooWAtwZN69cWy5PMjZwgpqSwiNEJ1N1RU3oxFthKvH8yeF6 name=test_file name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU533gamma # [6518502.499134] gamma data-mesher[209]: time=2026-08-23T10:05:28.552Z level=INFO msg="download complete" name=test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU signed_at="2026-08-23 10:05:18.86 +0000 UTC" signed_by="EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU=" peer=12D3KooW9rnrisfUBm9WMbM8psXNrXVpcVpbJeAg2ecpktWsxxL3 written=true elapsed=3.117123ms534Error: failed to update file: 403 Forbidden, signer EAfDrMsAyzx/O0X2tXut83PVizS9uNVow8YCtvPrhdU= is not authorized for this file test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU535alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/i662g5nc00nm69g46rz14s8lpx978m49-shared-data-mesher-network_network.pub, in 0.03 seconds)536(finished: run the VM test script, in 32.58 seconds)537alpha # [6518502.942874] alpha data-mesher[210]: time=2026-08-23T10:05:28.995Z level=INFO msg=http_request uri=/files/test_ns/EAfDrMsAyzx_O0X2tXut83PVizS9uNVow8YCtvPrhdU status=403538test script finished in 33.36s539cleanup540kill NspawnMachine (pid 53)541kill NspawnMachine (pid 54)542Container alpha terminated by signal KILL.543Container beta terminated by signal KILL.544kill NspawnMachine (pid 56)545Container gamma terminated by signal KILL.546(finished: cleanup, in 0.64 seconds)

succeeded container-test-run-data-mesher checks.aarch64-linux.data-mesher · build #464 · raw

succeeded `container-test-run-data-mesher` `checks.aarch64-linux.data-mesher` · build #464 · raw