nixbot

builds

succeeded container-test-run-data-mesher checks.aarch64-linux.data-mesher · build #582 · 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)13beta: systemd-nspawn running (pid 54)14gamma: systemd-nspawn running (pid 55)15alpha: Waiting for journal at /build/vm-state-alpha/var/log/journal...16beta: Waiting for journal at /build/vm-state-beta/var/log/journal...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(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 alpha on /build/vm-state-alpha.30░ Spawning container beta on /build/vm-state-beta.31░ Spawning container gamma on /build/vm-state-gamma.32alpha # [27633.858427] alpha systemd-journald[88]: Journal started33beta # [27633.877616] beta systemd-journald[87]: Journal started34gamma # [27633.848097] gamma systemd-journald[87]: Journal started35gamma # [27633.848358] gamma systemd-journald[87]: Runtime Journal (/run/log/journal/19874b3321fe4e129ae1ab10292ff397) is 8M, max 2.5G, 2.4G free.36gamma # [27633.857092] gamma systemd[1]: Starting Flush Journal to Persistent Storage...37beta # [27633.877673] beta systemd-journald[87]: Runtime Journal (/run/log/journal/0f320b3bcb984291901edbeacc3739fa) is 8M, max 2.5G, 2.4G free.38alpha # [27633.858484] alpha systemd-journald[88]: Runtime Journal (/run/log/journal/ff42d42458774cd4b1ce5b0d08c07545) is 8M, max 2.5G, 2.4G free.39beta # [27633.879779] beta systemd[1]: Starting Flush Journal to Persistent Storage...40alpha # [27633.870747] alpha systemd[1]: Starting Flush Journal to Persistent Storage...41beta # [27633.890912] beta systemd-journald[87]: Time spent on flushing to /var/log/journal/0f320b3bcb984291901edbeacc3739fa is 1.560ms for 3 entries.42alpha # [27633.871696] alpha systemd[1]: Starting Network Name Resolution...43beta # [27633.890912] beta systemd-journald[87]: System Journal (/var/log/journal/0f320b3bcb984291901edbeacc3739fa) is 8M, max 4G, 3.9G free.44alpha # [27633.872407] alpha systemd[1]: Starting Create Static Device Nodes in /dev...45beta # [27633.892317] beta systemd[1]: Finished Create Static Device Nodes in /dev.46alpha # [27633.881395] alpha systemd-journald[88]: Time spent on flushing to /var/log/journal/ff42d42458774cd4b1ce5b0d08c07545 is 1.469ms for 5 entries.47beta # [27633.898672] beta systemd[1]: Reached target Preparation for Local File Systems.48beta # [27633.898793] beta systemd[1]: Reached target Local File Systems.49alpha # [27633.881395] alpha systemd-journald[88]: System Journal (/var/log/journal/ff42d42458774cd4b1ce5b0d08c07545) is 8M, max 4G, 3.9G free.50gamma # [27633.858187] gamma systemd[1]: Starting Network Name Resolution...51gamma # [27633.859143] gamma systemd[1]: Starting Create Static Device Nodes in /dev...52gamma # [27633.865897] gamma systemd-journald[87]: Time spent on flushing to /var/log/journal/19874b3321fe4e129ae1ab10292ff397 is 1.832ms for 5 entries.53beta # [27633.900203] beta systemd[1]: Listening on Boot Loader Control Service Socket.54alpha # [27633.887969] alpha systemd[1]: Finished Create Static Device Nodes in /dev.55beta # [27633.900255] beta systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container56alpha # [27633.888283] alpha systemd[1]: Reached target Preparation for Local File Systems.57gamma # [27633.865897] gamma systemd-journald[87]: System Journal (/var/log/journal/19874b3321fe4e129ae1ab10292ff397) is 8M, max 4G, 3.9G free.58beta # [27633.900992] beta systemd[1]: Starting Save Transient machine-id to Disk...59alpha # [27633.888385] alpha systemd[1]: Reached target Local File Systems.60beta # [27633.901030] beta systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys61beta # [27633.917817] beta systemd[1]: Finished Flush Journal to Persistent Storage.62gamma # [27633.875486] gamma systemd[1]: Finished Create Static Device Nodes in /dev.63alpha # [27633.889139] alpha systemd[1]: Listening on Boot Loader Control Service Socket.64alpha # [27633.889186] alpha systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container65beta # [27633.918757] beta systemd[1]: Starting Create System Files and Directories...66gamma # [27633.875733] gamma systemd[1]: Reached target Preparation for Local File Systems.67alpha # [27633.890024] alpha systemd[1]: Starting Save Transient machine-id to Disk...68gamma # [27633.875821] gamma systemd[1]: Reached target Local File Systems.69gamma # [27633.876589] gamma systemd[1]: Listening on Boot Loader Control Service Socket.70gamma # [27633.876639] gamma systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container71gamma # [27633.877497] gamma systemd[1]: Starting Save Transient machine-id to Disk...72gamma # [27633.877533] gamma systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys73gamma # [27633.898569] gamma systemd[1]: Finished Flush Journal to Persistent Storage.74gamma # [27633.900154] gamma systemd[1]: Starting Create System Files and Directories...75gamma # [27633.919152] gamma systemd-tmpfiles[135]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted76gamma # [27633.919388] gamma systemd-tmpfiles[135]: fchmod() of /var/log/journal failed: Operation not permitted77gamma # [27633.919559] gamma systemd-tmpfiles[135]: fchmod() of /var/log/journal/19874b3321fe4e129ae1ab10292ff397 failed: Operation not permitted78gamma # [27633.919820] gamma systemd-tmpfiles[135]: fchmod() of /run/log/journal failed: Operation not permitted79gamma # [27633.922035] gamma systemd[1]: Finished Create System Files and Directories.80gamma # [27633.923221] gamma systemd[1]: Starting Rebuild Journal Catalog...81gamma # [27633.923991] gamma systemd[1]: Starting Record System Boot/Shutdown in UTMP...82alpha # [27633.890053] alpha systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys83alpha # [27633.898560] alpha systemd[1]: Finished Flush Journal to Persistent Storage.84alpha # [27633.902422] alpha systemd[1]: Starting Create System Files and Directories...85alpha # [27633.916260] alpha systemd-tmpfiles[134]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted86alpha # [27633.916458] alpha systemd-tmpfiles[134]: fchmod() of /var/log/journal failed: Operation not permitted87alpha # [27633.916593] alpha systemd-tmpfiles[134]: fchmod() of /var/log/journal/ff42d42458774cd4b1ce5b0d08c07545 failed: Operation not permitted88alpha # [27633.916798] alpha systemd-tmpfiles[134]: fchmod() of /run/log/journal failed: Operation not permitted89alpha # [27633.918159] alpha systemd[1]: Finished Create System Files and Directories.90alpha # [27633.919225] alpha systemd[1]: Starting Rebuild Journal Catalog...91alpha # [27633.919926] alpha systemd[1]: Starting Record System Boot/Shutdown in UTMP...92beta # [27633.934752] beta systemd-tmpfiles[129]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted93beta # [27633.934938] beta systemd-tmpfiles[129]: fchmod() of /var/log/journal failed: Operation not permitted94beta # [27633.935078] beta systemd-tmpfiles[129]: fchmod() of /var/log/journal/0f320b3bcb984291901edbeacc3739fa failed: Operation not permitted95beta # [27633.935325] beta systemd-tmpfiles[129]: fchmod() of /run/log/journal failed: Operation not permitted96alpha # [27633.930947] alpha systemd[1]: Finished Record System Boot/Shutdown in UTMP.97alpha # [27633.942224] alpha systemd[1]: Finished Rebuild Journal Catalog.98alpha # [27633.943296] alpha systemd[1]: Starting Update is Completed...99alpha # [27633.955509] alpha systemd[1]: Finished Save Transient machine-id to Disk.100alpha # [27633.955733] alpha systemd[1]: Finished Update is Completed.101alpha # [27634.020249] alpha systemd[1]: Finished Firewall.102alpha # [27634.020407] alpha systemd[1]: Reached target Preparation for Network.103alpha # [27634.020612] alpha systemd[1]: Listening on Network Management Resolve Hook Socket.104alpha # [27634.021566] alpha systemd[1]: Starting Network Management...105gamma # [27633.936083] gamma systemd[1]: Finished Record System Boot/Shutdown in UTMP.106gamma # [27633.946620] gamma systemd[1]: Finished Rebuild Journal Catalog.107gamma # [27633.947772] gamma systemd[1]: Starting Update is Completed...108gamma # [27633.955485] gamma systemd[1]: Finished Save Transient machine-id to Disk.109gamma # [27633.958573] gamma systemd[1]: Finished Update is Completed.110gamma # [27634.013582] gamma systemd[1]: Finished Firewall.111gamma # [27634.013754] gamma systemd[1]: Reached target Preparation for Network.112gamma # [27634.013974] gamma systemd[1]: Listening on Network Management Resolve Hook Socket.113gamma # [27634.014991] gamma systemd[1]: Starting Network Management...114beta # [27633.936736] beta systemd[1]: Finished Create System Files and Directories.115beta # [27633.937760] beta systemd[1]: Starting Rebuild Journal Catalog...116beta # [27633.938616] beta systemd[1]: Starting Record System Boot/Shutdown in UTMP...117beta # [27633.952322] beta systemd[1]: Finished Record System Boot/Shutdown in UTMP.118beta # [27633.955483] beta systemd[1]: Finished Save Transient machine-id to Disk.119beta # [27633.959487] beta systemd[1]: Finished Rebuild Journal Catalog.120beta # [27633.960515] beta systemd[1]: Starting Update is Completed...121beta # [27633.970142] beta systemd[1]: Finished Update is Completed.122beta # [27634.056367] beta systemd[1]: Finished Firewall.123beta # [27634.056536] beta systemd[1]: Reached target Preparation for Network.124beta # [27634.056747] beta systemd[1]: Listening on Network Management Resolve Hook Socket.125beta # [27634.057709] beta systemd[1]: Starting Network Management...126alpha # [27634.405499] alpha systemd-networkd[206]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted127alpha # [27634.405594] alpha systemd-networkd[206]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted128alpha # [27634.412063] alpha systemd-networkd[206]: /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.129alpha # [27634.412232] alpha systemd-networkd[206]: /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.130alpha # [27634.412392] alpha systemd-networkd[206]: lo: Link UP131alpha # [27634.412396] alpha systemd-networkd[206]: lo: Gained carrier132alpha # [27634.412569] alpha systemd-networkd[206]: eth1: Configuring with /etc/systemd/network/40-eth1.network.133alpha # [27634.412980] alpha systemd[1]: Started Network Management.134alpha # [27634.413065] alpha systemd-networkd[206]: eth1: Link UP135alpha # [27634.413392] alpha systemd-networkd[206]: eth1: Gained carrier136alpha # [27634.414358] alpha systemd[1]: Starting Enable Persistent Storage in systemd-networkd...137alpha # [27634.460272] alpha systemd[1]: Finished Enable Persistent Storage in systemd-networkd.138alpha # [27634.501134] alpha systemd-resolved[112]: Positive Trust Anchors:139alpha # [27634.501147] alpha systemd-resolved[112]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d140alpha # [27634.501150] alpha systemd-resolved[112]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16141alpha # [27634.501191] alpha systemd-resolved[112]: 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 test142alpha # [27634.523445] alpha systemd-resolved[112]: Using system hostname 'alpha'.143alpha # [27634.524854] alpha systemd[1]: Started Network Name Resolution.144alpha # [27634.524952] alpha systemd[1]: Reached target Network.145alpha # [27634.525034] alpha systemd[1]: Reached target System Initialization.146alpha # [27634.525097] alpha systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container147alpha # [27634.525127] alpha systemd[1]: Started Daily Cleanup of Temporary Directories.148alpha # [27634.525150] alpha systemd[1]: Reached target Timer Units.149alpha # [27634.525309] alpha systemd[1]: Listening on D-Bus System Message Bus Socket.150alpha # [27634.525449] alpha systemd[1]: Listening on Nix Daemon Socket.151alpha # [27634.525591] alpha systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.152alpha # [27634.525619] alpha systemd[1]: Reached target Socket Units.153alpha # [27634.525664] alpha systemd[1]: Reached target Basic System.154alpha # [27634.527230] alpha systemd[1]: Starting data mesher daemon...155alpha # [27634.528240] alpha systemd[1]: Starting Import lastlog data into lastlog2 database...156alpha # [27634.529229] alpha systemd[1]: Starting Name Service Cache Daemon (nsncd)...157alpha # [27634.530692] alpha systemd[1]: Starting D-Bus System Message Bus...158alpha # [27634.549668] alpha systemd[1]: Finished Import lastlog data into lastlog2 database.159alpha # [27634.644764] alpha systemd[1]: Started Name Service Cache Daemon (nsncd).160alpha # [27634.644838] alpha systemd[1]: Reached target Host and Network Name Lookups.161alpha # [27634.644915] alpha nsncd[213]: Sep 04 15:07:34.630 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"162alpha # [27634.644909] alpha systemd[1]: Reached target User and Group Name Lookups.163alpha # [27634.656391] alpha systemd[1]: Starting User Login Management...164beta # [27634.409555] beta systemd-networkd[203]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted165beta # [27634.409639] beta systemd-networkd[203]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted166beta # [27634.416092] beta systemd-networkd[203]: /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.167beta # [27634.416261] beta systemd-networkd[203]: /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.168beta # [27634.416406] beta systemd-networkd[203]: lo: Link UP169beta # [27634.416410] beta systemd-networkd[203]: lo: Gained carrier170beta # [27634.416587] beta systemd-networkd[203]: eth1: Configuring with /etc/systemd/network/40-eth1.network.171beta # [27634.416963] beta systemd[1]: Started Network Management.172beta # [27634.417035] beta systemd-networkd[203]: eth1: Link UP173beta # [27634.417251] beta systemd-networkd[203]: eth1: Gained carrier174beta # [27634.418071] beta systemd[1]: Starting Enable Persistent Storage in systemd-networkd...175beta # [27634.461730] beta systemd[1]: Finished Enable Persistent Storage in systemd-networkd.176beta # [27634.481424] beta systemd-resolved[89]: Positive Trust Anchors:177beta # [27634.481436] beta systemd-resolved[89]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d178beta # [27634.481438] beta systemd-resolved[89]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16179beta # [27634.481473] beta systemd-resolved[89]: 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 test180beta # [27634.502867] beta systemd-resolved[89]: Using system hostname 'beta'.181beta # [27634.504623] beta systemd[1]: Started Network Name Resolution.182beta # [27634.504752] beta systemd[1]: Reached target Network.183beta # [27634.504874] beta systemd[1]: Reached target System Initialization.184beta # [27634.504969] beta systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container185beta # [27634.505021] beta systemd[1]: Started Daily Cleanup of Temporary Directories.186beta # [27634.505058] beta systemd[1]: Reached target Timer Units.187beta # [27634.505303] beta systemd[1]: Listening on D-Bus System Message Bus Socket.188beta # [27634.505525] beta systemd[1]: Listening on Nix Daemon Socket.189beta # [27634.505740] beta systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.190beta # [27634.505788] beta systemd[1]: Reached target Socket Units.191beta # [27634.505865] beta systemd[1]: Reached target Basic System.192beta # [27634.507998] beta systemd[1]: Starting data mesher daemon...193beta # [27634.509263] beta systemd[1]: Starting Import lastlog data into lastlog2 database...194beta # [27634.510773] beta systemd[1]: Starting Name Service Cache Daemon (nsncd)...195beta # [27634.512952] beta systemd[1]: Starting D-Bus System Message Bus...196beta # [27634.530989] beta systemd[1]: Finished Import lastlog data into lastlog2 database.197beta # [27634.648055] beta systemd[1]: Started Name Service Cache Daemon (nsncd).198beta # [27634.648130] beta systemd[1]: Reached target Host and Network Name Lookups.199beta # [27634.648288] beta nsncd[210]: Sep 04 15:07:34.633 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"200beta # [27634.648200] beta systemd[1]: Reached target User and Group Name Lookups.201beta # [27634.656677] beta systemd[1]: Starting User Login Management...202beta # [27634.657648] beta systemd[1]: Starting Permit User Sessions...203gamma # [27634.413905] gamma systemd-networkd[205]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted204gamma # [27634.413990] gamma systemd-networkd[205]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted205gamma # [27634.422320] gamma 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.206gamma # [27634.422487] gamma 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.207gamma # [27634.422626] gamma systemd-networkd[205]: lo: Link UP208gamma # [27634.422631] gamma systemd-networkd[205]: lo: Gained carrier209gamma # [27634.422779] gamma systemd-networkd[205]: eth1: Configuring with /etc/systemd/network/40-eth1.network.210gamma # [27634.423168] gamma systemd[1]: Started Network Management.211gamma # [27634.452339] gamma systemd-networkd[205]: eth1: Link UP212gamma # [27634.452489] gamma systemd[1]: Starting Enable Persistent Storage in systemd-networkd...213gamma # [27634.452612] gamma systemd-networkd[205]: eth1: Gained carrier214gamma # [27634.485271] gamma systemd-resolved[107]: Positive Trust Anchors:215gamma # [27634.485282] gamma systemd-resolved[107]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d216gamma # [27634.485285] gamma systemd-resolved[107]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16217gamma # [27634.485319] gamma systemd-resolved[107]: 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 test218gamma # [27634.502062] gamma systemd[1]: Finished Enable Persistent Storage in systemd-networkd.219gamma # [27634.506711] gamma systemd-resolved[107]: Using system hostname 'gamma'.220gamma # [27634.508027] gamma systemd[1]: Started Network Name Resolution.221gamma # [27634.508127] gamma systemd[1]: Reached target Network.222gamma # [27634.508209] gamma systemd[1]: Reached target System Initialization.223gamma # [27634.508273] gamma systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container224gamma # [27634.508304] gamma systemd[1]: Started Daily Cleanup of Temporary Directories.225gamma # [27634.508332] gamma systemd[1]: Reached target Timer Units.226gamma # [27634.508479] gamma systemd[1]: Listening on D-Bus System Message Bus Socket.227gamma # [27634.508703] gamma systemd[1]: Listening on Nix Daemon Socket.228gamma # [27634.508858] gamma systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.229gamma # [27634.508888] gamma systemd[1]: Reached target Socket Units.230gamma # [27634.508941] gamma systemd[1]: Reached target Basic System.231gamma # [27634.510314] gamma systemd[1]: Starting data mesher daemon...232gamma # [27634.511140] gamma systemd[1]: Starting Import lastlog data into lastlog2 database...233gamma # [27634.512034] gamma systemd[1]: Starting Name Service Cache Daemon (nsncd)...234gamma # [27634.513545] gamma systemd[1]: Starting D-Bus System Message Bus...235gamma # [27634.531025] gamma systemd[1]: Finished Import lastlog data into lastlog2 database.236gamma # [27634.623247] gamma nsncd[212]: Sep 04 15:07:34.609 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"237gamma # [27634.623312] gamma systemd[1]: Started Name Service Cache Daemon (nsncd).238gamma # [27634.623382] gamma systemd[1]: Reached target Host and Network Name Lookups.239gamma # [27634.623453] gamma systemd[1]: Reached target User and Group Name Lookups.240gamma # [27634.624973] gamma systemd[1]: Starting User Login Management...241gamma # [27634.625931] gamma systemd[1]: Starting Permit User Sessions...242gamma # [27634.663650] gamma systemd[1]: Finished Permit User Sessions.243gamma # [27634.664826] gamma systemd[1]: Started Console Getty.244gamma # [27634.664875] gamma systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0245gamma # [27634.664899] gamma systemd[1]: Reached target Login Prompts.246gamma # [27634.769437] gamma dbus-broker-launch[213]: Looking up NSS user entry for 'systemd-timesync'...247gamma # [27634.770846] gamma dbus-broker-launch[213]: NSS returned no entry for 'systemd-timesync'248gamma # [27634.770846] gamma dbus-broker-launch[213]: Invalid user-name in /nix/store/y1xvnyfk8grlcjwhifz48bs8cwjiagww-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"249gamma # [27634.771300] gamma systemd[1]: Started D-Bus System Message Bus.250gamma # [27634.779676] gamma dbus-broker-launch[213]: Ready251gamma # [27634.835830] gamma systemd[1]: etc-machine\x2did.mount: Deactivated successfully.252alpha # [27634.657350] alpha systemd[1]: Starting Permit User Sessions...253beta # [27634.668042] beta systemd[1]: Finished Permit User Sessions.254beta # [27634.669136] beta systemd[1]: Started Console Getty.255alpha # [27634.668262] alpha systemd[1]: Finished Permit User Sessions.256beta # [27634.669181] beta systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0257alpha # [27634.669227] alpha systemd[1]: Started Console Getty.258beta # [27634.669203] beta systemd[1]: Reached target Login Prompts.259alpha # [27634.669266] alpha systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0260beta # [27634.788705] beta dbus-broker-launch[211]: Looking up NSS user entry for 'systemd-timesync'...261alpha # [27634.669284] alpha systemd[1]: Reached target Login Prompts.262beta # [27634.789994] beta dbus-broker-launch[211]: NSS returned no entry for 'systemd-timesync'263alpha # [27634.781470] alpha dbus-broker-launch[214]: Looking up NSS user entry for 'systemd-timesync'...264beta # [27634.789994] beta dbus-broker-launch[211]: Invalid user-name in /nix/store/y1xvnyfk8grlcjwhifz48bs8cwjiagww-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"265alpha # [27634.782127] alpha dbus-broker-launch[214]: NSS returned no entry for 'systemd-timesync'266beta # [27634.790373] beta systemd[1]: Started D-Bus System Message Bus.267alpha # [27634.782127] alpha dbus-broker-launch[214]: Invalid user-name in /nix/store/y1xvnyfk8grlcjwhifz48bs8cwjiagww-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"268beta # [27634.799714] beta dbus-broker-launch[211]: Ready269alpha # [27634.782498] alpha systemd[1]: Started D-Bus System Message Bus.270beta # [27634.872473] beta systemd[1]: etc-machine\x2did.mount: Deactivated successfully.271alpha # [27634.791047] alpha dbus-broker-launch[214]: Ready272alpha # [27634.843316] alpha systemd[1]: etc-machine\x2did.mount: Deactivated successfully.273beta # [27635.063435] beta data-mesher[208]: time=2026-09-04T15:07:35.049Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]274beta # [27635.064524] beta data-mesher[208]: time=2026-09-04T15:07:35.050Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs: [/dns/alpha.clan/tcp/7946]} {12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB275beta # [27635.064524] beta data-mesher[208]: time=2026-09-04T15:07:35.050Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml276beta # [27635.098876] beta data-mesher[208]: time=2026-09-04T15:07:35.084Z level=INFO msg="checking file integrity"277beta # [27635.099046] beta data-mesher[208]: time=2026-09-04T15:07:35.084Z level=INFO msg="file integrity check complete"278beta # [27635.102882] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="libp2p host created" peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB 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]"279beta # [27635.102915] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=GET path=/files280beta # [27635.102915] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name281beta # [27635.102915] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name282beta # [27635.102979] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="starting server"283beta # [27635.103112] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="HTTP server listening" address=[::1]:7331284beta # [27635.103164] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331285beta # [27635.103189] beta data-mesher[208]: time=2026-09-04T15:07:35.088Z level=INFO msg="waiting for DHT to populate" delay=10s286beta # [27635.109439] beta data-mesher[208]: time=2026-09-04T15:07:35.095Z level=INFO msg="peer connected" peer_id=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs remote_addr=/ip4/192.168.1.1/tcp/7946287beta # [27635.110590] beta data-mesher[208]: time=2026-09-04T15:07:35.096Z level=INFO msg="peer connected" peer_id=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs remote_addr=/ip4/192.168.1.1/tcp/7946288beta # [27635.117506] beta data-mesher[208]: time=2026-09-04T15:07:35.103Z level=INFO msg="peer connected" peer_id=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB remote_addr=/ip4/192.168.1.3/tcp/7946289beta # [27635.118634] beta data-mesher[208]: time=2026-09-04T15:07:35.104Z level=INFO msg="peer connected" peer_id=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB remote_addr=/ip4/192.168.1.3/tcp/7946290beta # [27635.173136] beta systemd-logind[227]: New seat seat0.291beta # [27635.173322] beta systemd[1]: Started User Login Management.292beta # [27635.216707] beta systemd[1]: Starting linger-users.service...293beta # [27635.230750] beta systemd[1]: linger-users.service: Deactivated successfully.294beta # [27635.230837] beta systemd[1]: Finished linger-users.service.295alpha # [27635.051259] alpha data-mesher[211]: time=2026-09-04T15:07:35.037Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]296alpha # [27635.052516] alpha data-mesher[211]: time=2026-09-04T15:07:35.038Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs: [/dns/alpha.clan/tcp/7946]} {12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs297alpha # [27635.052588] alpha data-mesher[211]: time=2026-09-04T15:07:35.038Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml298alpha # [27635.098799] alpha data-mesher[211]: time=2026-09-04T15:07:35.084Z level=INFO msg="checking file integrity"299alpha # [27635.098904] alpha data-mesher[211]: time=2026-09-04T15:07:35.084Z level=INFO msg="file integrity check complete"300alpha # [27635.102879] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="libp2p host created" peer_id=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs 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]"301alpha # [27635.102958] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=GET path=/files302alpha # [27635.102958] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name303alpha # [27635.102958] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name304alpha # [27635.102958] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="starting server"305alpha # [27635.103050] alpha data-mesher[211]: time=2026-09-04T15:07:35.088Z level=INFO msg="waiting for DHT to populate" delay=10s306alpha # [27635.103534] alpha data-mesher[211]: time=2026-09-04T15:07:35.089Z level=INFO msg="HTTP server listening" address=[::1]:7331307alpha # [27635.103534] alpha data-mesher[211]: time=2026-09-04T15:07:35.089Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331308alpha # [27635.108544] alpha data-mesher[211]: time=2026-09-04T15:07:35.094Z level=INFO msg="peer connected" peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB remote_addr=/ip4/192.168.1.2/tcp/7946309alpha # [27635.111746] alpha data-mesher[211]: time=2026-09-04T15:07:35.097Z level=INFO msg="peer connected" peer_id=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB remote_addr=/ip4/192.168.1.3/tcp/7946310alpha # [27635.112170] alpha data-mesher[211]: time=2026-09-04T15:07:35.097Z level=INFO msg="peer connected" peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB remote_addr=/ip4/192.168.1.2/tcp/51748311alpha # [27635.169289] alpha systemd-logind[230]: New seat seat0.312alpha # [27635.169476] alpha systemd[1]: Started User Login Management.313alpha # [27635.216652] alpha systemd[1]: Starting linger-users.service...314alpha # [27635.230595] alpha systemd[1]: linger-users.service: Deactivated successfully.315alpha # [27635.230686] alpha systemd[1]: Finished linger-users.service.316gamma # [27635.051311] gamma data-mesher[210]: time=2026-09-04T15:07:35.037Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo]317gamma # [27635.052519] gamma data-mesher[210]: time=2026-09-04T15:07:35.038Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs: [/dns/alpha.clan/tcp/7946]} {12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB: [/dns/beta.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB318gamma # [27635.052572] gamma data-mesher[210]: time=2026-09-04T15:07:35.038Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml319gamma # [27635.098794] gamma data-mesher[210]: time=2026-09-04T15:07:35.084Z level=INFO msg="checking file integrity"320gamma # [27635.098896] gamma data-mesher[210]: time=2026-09-04T15:07:35.084Z level=INFO msg="file integrity check complete"321gamma # [27635.102946] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="libp2p host created" peer_id=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB 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]"322gamma # [27635.103037] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name323gamma # [27635.103037] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=GET path=/files324gamma # [27635.103037] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name325gamma # [27635.103037] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="starting server"326gamma # [27635.103097] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="waiting for DHT to populate" delay=10s327gamma # [27635.103282] gamma data-mesher[210]: time=2026-09-04T15:07:35.088Z level=INFO msg="HTTP server listening" address=[::1]:7331328gamma # [27635.103735] gamma data-mesher[210]: time=2026-09-04T15:07:35.089Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331329gamma # [27635.110643] gamma data-mesher[210]: time=2026-09-04T15:07:35.096Z level=INFO msg="peer connected" peer_id=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs remote_addr=/ip4/192.168.1.1/tcp/7946330gamma # [27635.116750] gamma data-mesher[210]: time=2026-09-04T15:07:35.102Z level=INFO msg="peer connected" peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB remote_addr=/ip4/192.168.1.2/tcp/7946331gamma # [27635.118329] gamma data-mesher[210]: time=2026-09-04T15:07:35.104Z level=INFO msg="peer connected" peer_id=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB remote_addr=/ip4/192.168.1.2/tcp/37562332gamma # [27635.163037] gamma systemd-logind[229]: New seat seat0.333gamma # [27635.163514] gamma systemd[1]: Started User Login Management.334gamma # [27635.164625] gamma systemd[1]: Starting linger-users.service...335gamma # [27635.225609] gamma systemd[1]: linger-users.service: Deactivated successfully.336gamma # [27635.225814] gamma systemd[1]: Finished linger-users.service.337beta # [27635.556189] beta systemd-networkd[203]: eth1: Gained IPv6LL338gamma # [27635.780493] gamma systemd-networkd[205]: eth1: Gained IPv6LL339alpha # [27636.100254] alpha systemd-networkd[206]: eth1: Gained IPv6LL340alpha: still waiting for container 'alpha' to reach ready state...341alpha # [27645.103482] alpha data-mesher[211]: time=2026-09-04T15:07:45.089Z level=INFO msg="performing state exchange with peers on join" count=1342alpha # [27645.103885] alpha data-mesher[211]: time=2026-09-04T15:07:45.089Z level=DEBUG msg="initiating state exchange" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s343alpha # [27645.104255] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="received state sync from peer" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB344alpha # [27645.104303] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB345alpha # [27645.104426] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB346alpha # [27645.104480] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="state exchange complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s347alpha # [27645.104542] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="server started"348alpha # [27645.104627] alpha data-mesher[211]: time=2026-09-04T15:07:45.090Z level=INFO msg="starting expired-file sweeper" interval=1m0s349alpha # [27645.104742] alpha systemd[1]: Started data mesher daemon.350alpha # [27645.105052] alpha systemd[1]: Reached target Multi-User System.351alpha # [27645.105292] alpha systemd[1]: Startup finished in 11.653s.352beta # [27645.103406] beta data-mesher[208]: time=2026-09-04T15:07:45.089Z level=INFO msg="performing state exchange with peers on join" count=1353beta # [27645.104156] beta data-mesher[208]: time=2026-09-04T15:07:45.089Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s354beta # [27645.104156] beta data-mesher[208]: time=2026-09-04T15:07:45.089Z level=INFO msg="received state sync from peer" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs355beta # [27645.104156] beta data-mesher[208]: time=2026-09-04T15:07:45.089Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs356beta # [27645.104521] beta data-mesher[208]: time=2026-09-04T15:07:45.090Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs357gamma # [27645.103420] gamma data-mesher[210]: time=2026-09-04T15:07:45.089Z level=INFO msg="performing state exchange with peers on join" count=1358gamma # [27645.103420] gamma data-mesher[210]: time=2026-09-04T15:07:45.089Z level=DEBUG msg="initiating state exchange" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s359gamma # [27645.108896] gamma data-mesher[210]: time=2026-09-04T15:07:45.094Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB360gamma # [27645.108896] gamma data-mesher[210]: time=2026-09-04T15:07:45.094Z level=INFO msg="state exchange complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s361gamma # [27645.109035] gamma data-mesher[210]: time=2026-09-04T15:07:45.094Z level=INFO msg="server started"362gamma # [27645.109097] gamma data-mesher[210]: time=2026-09-04T15:07:45.094Z level=INFO msg="starting expired-file sweeper" interval=1m0s363gamma # [27645.109243] gamma systemd[1]: Started data mesher daemon.364gamma # [27645.109777] gamma systemd[1]: Reached target Multi-User System.365gamma # [27645.110121] gamma systemd[1]: Startup finished in 11.659s.366beta # [27645.104521] beta data-mesher[208]: time=2026-09-04T15:07:45.090Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s367beta # [27645.104644] beta data-mesher[208]: time=2026-09-04T15:07:45.090Z level=INFO msg="server started"368beta # [27645.104702] beta data-mesher[208]: time=2026-09-04T15:07:45.090Z level=INFO msg="starting expired-file sweeper" interval=1m0s369beta # [27645.104776] beta systemd[1]: Started data mesher daemon.370beta # [27645.105056] beta systemd[1]: Reached target Multi-User System.371beta # [27645.105258] beta systemd[1]: Startup finished in 11.650s.372beta # [27645.108122] beta data-mesher[208]: time=2026-09-04T15:07:45.093Z level=INFO msg="received state sync from peer" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB373beta # [27645.108122] beta data-mesher[208]: time=2026-09-04T15:07:45.093Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB374alpha: (finished: waiting for unit data-mesher.service, in 12.66 seconds)375beta: waiting for unit data-mesher.service376beta: (finished: waiting for unit data-mesher.service, in 0.02 seconds)377gamma: waiting for unit data-mesher.service378gamma: (finished: waiting for unit data-mesher.service, in 0.01 seconds)379alpha: must succeed: echo -n 'hello world' > /tmp/test_file380alpha: (finished: must succeed: echo -n 'hello world' > /tmp/test_file, in 0.01 seconds)381alpha: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key382alpha: (finished: waiting for success: data-mesher file update /tmp/test_file --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.03 seconds)383??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.384 File "/nix/store/cag5izn0mcnmyi82zb3rwfs1s1afa6q5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39385alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file386??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.387 File "/nix/store/cag5izn0mcnmyi82zb3rwfs1s1afa6q5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39388alpha: (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)389beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file390alpha # [27645.664089] alpha data-mesher[211]: time=2026-09-04T15:07:45.649Z level=INFO msg=http_request uri=/files/test_file status=204391beta # [27650.105297] beta data-mesher[208]: time=2026-09-04T15:07:50.091Z level=DEBUG msg="attempting push/pull" peer_count=2392beta # [27650.105297] beta data-mesher[208]: time=2026-09-04T15:07:50.091Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s393beta # [27650.106364] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs394beta # [27650.106427] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=DEBUG msg="new file detected" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs name=test_file name=test_file395beta # [27650.106427] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s396beta # [27650.106492] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=DEBUG msg="push/pull successful" interval=5s397beta # [27650.106492] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="received state sync from peer" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs398beta # [27650.106492] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs399beta # [27650.106568] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=DEBUG msg="new file detected" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs name=test_file name=test_file400beta # [27650.106568] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="scheduling file download" name=test_file401beta # [27650.106617] beta data-mesher[208]: time=2026-09-04T15:07:50.092Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-04 15:07:45.644 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs402beta # [27650.128364] beta data-mesher[208]: time=2026-09-04T15:07:50.114Z level=INFO msg="download complete" name=test_file signed_at="2026-09-04 15:07:45.644 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs written=true elapsed=21.710105ms403alpha # [27650.105772] alpha data-mesher[211]: time=2026-09-04T15:07:50.091Z level=DEBUG msg="attempting push/pull" peer_count=2404alpha # [27650.106482] alpha data-mesher[211]: time=2026-09-04T15:07:50.091Z level=DEBUG msg="initiating state exchange" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s405gamma # [27650.109670] gamma data-mesher[210]: time=2026-09-04T15:07:50.095Z level=DEBUG msg="attempting push/pull" peer_count=2406alpha # [27650.106482] alpha data-mesher[211]: time=2026-09-04T15:07:50.091Z level=INFO msg="received state sync from peer" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB407gamma # [27650.109670] gamma data-mesher[210]: time=2026-09-04T15:07:50.095Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s408alpha # [27650.106482] alpha data-mesher[211]: time=2026-09-04T15:07:50.091Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB409gamma # [27650.110872] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs410alpha # [27650.106718] alpha data-mesher[211]: time=2026-09-04T15:07:50.092Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB411gamma # [27650.110967] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=DEBUG msg="new file detected" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs name=test_file name=test_file412alpha # [27650.106718] alpha data-mesher[211]: time=2026-09-04T15:07:50.092Z level=INFO msg="state exchange complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s413gamma # [27650.110967] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s414alpha # [27650.106835] alpha data-mesher[211]: time=2026-09-04T15:07:50.092Z level=DEBUG msg="push/pull successful" interval=5s415gamma # [27650.111078] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=DEBUG msg="push/pull successful" interval=5s416alpha # [27650.107010] alpha data-mesher[211]: time=2026-09-04T15:07:50.092Z level=INFO msg="received file request" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_file417gamma # [27650.111078] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=INFO msg="scheduling file download" name=test_file418alpha # [27650.110356] alpha data-mesher[211]: time=2026-09-04T15:07:50.096Z level=INFO msg="received state sync from peer" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB419gamma # [27650.111078] gamma data-mesher[210]: time=2026-09-04T15:07:50.096Z level=INFO msg="downloading file" name=test_file signed_at="2026-09-04 15:07:45.644 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs420alpha # [27650.110356] alpha data-mesher[211]: time=2026-09-04T15:07:50.096Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB421gamma # [27650.130040] gamma data-mesher[210]: time=2026-09-04T15:07:50.115Z level=INFO msg="download complete" name=test_file signed_at="2026-09-04 15:07:45.644 +0000 UTC" signed_by="azwT+VhTxA+BF73Hwq0uqdXHG8XvHU2BknoVXgmEjww=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs written=true elapsed=18.973586ms422alpha # [27650.110524] alpha data-mesher[211]: time=2026-09-04T15:07:50.096Z level=INFO msg="file transfer complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_file423alpha # [27650.111602] alpha data-mesher[211]: time=2026-09-04T15:07:50.097Z level=INFO msg="received file request" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_file424alpha # [27650.113095] alpha data-mesher[211]: time=2026-09-04T15:07:50.098Z level=INFO msg="file transfer complete" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_file425beta: (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)426gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_file && grep -q 'hello world' /var/lib/data-mesher/files/home/test_file427gamma: (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)428beta: waiting for success: data-mesher file delete test_file --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key429beta: (finished: waiting for success: data-mesher file delete test_file --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --url http://[::1]:7331 --key /nix/store/xysmjnpbvgzv55l8s8ixr5y3ih9fz7qc-admin.key, in 0.04 seconds)430alpha: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file431beta # [27650.765919] beta data-mesher[208]: time=2026-09-04T15:07:50.751Z level=INFO msg=http_request uri=/files/test_file status=204432alpha # [27655.111849] alpha data-mesher[211]: time=2026-09-04T15:07:55.093Z level=DEBUG msg="attempting push/pull" peer_count=2433alpha # [27655.111849] alpha data-mesher[211]: time=2026-09-04T15:07:55.094Z level=DEBUG msg="initiating state exchange" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB timeout=5s434alpha # [27655.120052] alpha data-mesher[211]: time=2026-09-04T15:07:55.102Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB435alpha # [27655.120052] alpha data-mesher[211]: time=2026-09-04T15:07:55.102Z level=INFO msg="state exchange complete" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB timeout=5s436alpha # [27655.120052] alpha data-mesher[211]: time=2026-09-04T15:07:55.102Z level=DEBUG msg="push/pull successful" interval=5s437alpha # [27655.120052] alpha data-mesher[211]: time=2026-09-04T15:07:55.102Z level=INFO msg="received state sync from peer" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB438alpha # [27655.120052] alpha data-mesher[211]: time=2026-09-04T15:07:55.102Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB439alpha # [27655.204074] alpha data-mesher[211]: time=2026-09-04T15:07:55.187Z level=DEBUG msg="imported tombstone" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB name=test_file written=true440gamma # [27655.116064] gamma data-mesher[210]: time=2026-09-04T15:07:55.098Z level=INFO msg="received state sync from peer" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs441gamma # [27655.116064] gamma data-mesher[210]: time=2026-09-04T15:07:55.098Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs442gamma # [27655.116064] gamma data-mesher[210]: time=2026-09-04T15:07:55.099Z level=DEBUG msg="attempting push/pull" peer_count=2443gamma # [27655.116064] gamma data-mesher[210]: time=2026-09-04T15:07:55.099Z level=DEBUG msg="initiating state exchange" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s444gamma # [27655.116700] gamma data-mesher[210]: time=2026-09-04T15:07:55.102Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB445gamma # [27655.216068] gamma data-mesher[210]: time=2026-09-04T15:07:55.198Z level=DEBUG msg="imported tombstone" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB name=test_file written=true446gamma # [27655.216068] gamma data-mesher[210]: time=2026-09-04T15:07:55.198Z level=INFO msg="state exchange complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB timeout=5s447gamma # [27655.216068] gamma data-mesher[210]: time=2026-09-04T15:07:55.198Z level=DEBUG msg="push/pull successful" interval=5s448beta # [27655.116073] beta data-mesher[208]: time=2026-09-04T15:07:55.097Z level=DEBUG msg="attempting push/pull" peer_count=2449beta # [27655.116073] beta data-mesher[208]: time=2026-09-04T15:07:55.098Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s450beta # [27655.116073] beta data-mesher[208]: time=2026-09-04T15:07:55.100Z level=INFO msg="received state sync from peer" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB451beta # [27655.116073] beta data-mesher[208]: time=2026-09-04T15:07:55.100Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB452beta # [27655.202523] beta data-mesher[208]: time=2026-09-04T15:07:55.188Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs453beta # [27655.202523] beta data-mesher[208]: time=2026-09-04T15:07:55.188Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s454beta # [27655.202815] beta data-mesher[208]: time=2026-09-04T15:07:55.188Z level=DEBUG msg="push/pull successful" interval=5s455alpha: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 5.07 seconds)456beta: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file457beta: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)458gamma: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file459gamma: (finished: waiting for success: test ! -f /var/lib/data-mesher/files/home/test_file, in 0.01 seconds)460alpha: must succeed: cat /nix/store/hvyj68m7dzqlw2vcafbrpp3d7wqaf9n4-per-machine-alpha-data-mesher-node-identity_identity.pub461alpha: (finished: must succeed: cat /nix/store/hvyj68m7dzqlw2vcafbrpp3d7wqaf9n4-per-machine-alpha-data-mesher-node-identity_identity.pub, in 0.01 seconds)462alpha: must succeed: echo -n 'namespace_data' > /tmp/ns_file463alpha: (finished: must succeed: echo -n 'namespace_data' > /tmp/ns_file, in 0.01 seconds)464alpha: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert465alpha: (finished: waiting for success: data-mesher file update /tmp/ns_file --name 'test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub --cert /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.cert, in 0.03 seconds)466alpha: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg467alpha: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg, in 0.02 seconds)468beta: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg469alpha # [27655.903586] alpha data-mesher[211]: time=2026-09-04T15:07:55.888Z level=INFO msg=http_request uri=/files/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg status=204470alpha # [27660.117537] alpha data-mesher[211]: time=2026-09-04T15:08:00.103Z level=DEBUG msg="attempting push/pull" peer_count=2471alpha # [27660.117949] alpha data-mesher[211]: time=2026-09-04T15:08:00.103Z level=DEBUG msg="initiating state exchange" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB timeout=5s472alpha # [27660.119527] alpha data-mesher[211]: time=2026-09-04T15:08:00.105Z level=INFO msg="received file request" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg473alpha # [27660.120918] alpha data-mesher[211]: time=2026-09-04T15:08:00.106Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB474alpha # [27660.121000] alpha data-mesher[211]: time=2026-09-04T15:08:00.106Z level=INFO msg="state exchange complete" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB timeout=5s475alpha # [27660.121097] alpha data-mesher[211]: time=2026-09-04T15:08:00.106Z level=DEBUG msg="push/pull successful" interval=5s476alpha # [27660.121467] alpha data-mesher[211]: time=2026-09-04T15:08:00.107Z level=INFO msg="file transfer complete" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg477alpha # [27660.203342] alpha data-mesher[211]: time=2026-09-04T15:08:00.189Z level=INFO msg="received state sync from peer" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB478alpha # [27660.203342] alpha data-mesher[211]: time=2026-09-04T15:08:00.189Z level=INFO msg="merging remote state" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB479alpha # [27660.205449] alpha data-mesher[211]: time=2026-09-04T15:08:00.190Z level=INFO msg="received file request" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg480alpha # [27660.205449] alpha data-mesher[211]: time=2026-09-04T15:08:00.191Z level=INFO msg="file transfer complete" peer=12D3KooWDS5ctW82z7iAVTytfqSKASiFBRhd1JX5Qycw8HxTQGXB network="1HaYkfW7+rjsl8ZQIy06lo5YeoT+kb4cp87sbrFSn+Y=" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg481alpha # [27660.214310] alpha data-mesher[211]: time=2026-09-04T15:08:00.199Z level=INFO msg="received state sync from peer" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB482alpha # [27660.214310] alpha data-mesher[211]: time=2026-09-04T15:08:00.199Z level=INFO msg="merging remote state" peer=12D3KooWA7rFHhemzy8DQyNdaBcd18HMNmwBYbpj83bqMh3JRvFB483gamma # [27660.118408] gamma data-mesher[210]: time=2026-09-04T15:08:00.104Z level=INFO msg="received state sync from peer" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs484gamma # [27660.118408] gamma data-mesher[210]: time=2026-09-04T15:08:00.104Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs485gamma # [27660.119180] gamma data-mesher[210]: time=2026-09-04T15:08:00.104Z level=DEBUG msg="new file detected" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs name=test_file name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg486gamma # [27660.119180] gamma data-mesher[210]: time=2026-09-04T15:08:00.104Z level=INFO msg="scheduling file download" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg487gamma # [27660.119303] gamma data-mesher[210]: time=2026-09-04T15:08:00.105Z level=INFO msg="downloading file" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg signed_at="2026-09-04 15:07:55.885 +0000 UTC" signed_by="LnPZqh0TaOUOyJXt/o8dVINFYPHYNlkyLz+6Uki2jjg=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs488gamma # [27660.123259] gamma data-mesher[210]: time=2026-09-04T15:08:00.109Z level=INFO msg="download complete" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg signed_at="2026-09-04 15:07:55.885 +0000 UTC" signed_by="LnPZqh0TaOUOyJXt/o8dVINFYPHYNlkyLz+6Uki2jjg=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs written=true elapsed=4.013177ms489gamma # [27660.213782] gamma data-mesher[210]: time=2026-09-04T15:08:00.199Z level=DEBUG msg="attempting push/pull" peer_count=2490gamma # [27660.213782] gamma data-mesher[210]: time=2026-09-04T15:08:00.199Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s491gamma # [27660.215314] gamma data-mesher[210]: time=2026-09-04T15:08:00.200Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs492gamma # [27660.215314] gamma data-mesher[210]: time=2026-09-04T15:08:00.200Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s493gamma # [27660.215314] gamma data-mesher[210]: time=2026-09-04T15:08:00.201Z level=DEBUG msg="push/pull successful" interval=5s494beta # [27660.202656] beta data-mesher[208]: time=2026-09-04T15:08:00.188Z level=DEBUG msg="attempting push/pull" peer_count=2495beta # [27660.203365] beta data-mesher[208]: time=2026-09-04T15:08:00.188Z level=DEBUG msg="initiating state exchange" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s496beta # [27660.203652] beta data-mesher[208]: time=2026-09-04T15:08:00.189Z level=INFO msg="merging remote state" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs497beta # [27660.204309] beta data-mesher[208]: time=2026-09-04T15:08:00.190Z level=DEBUG msg="new file detected" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs name=test_file name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg498beta # [27660.204396] beta data-mesher[208]: time=2026-09-04T15:08:00.190Z level=INFO msg="state exchange complete" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs timeout=5s499beta # [27660.204396] beta data-mesher[208]: time=2026-09-04T15:08:00.190Z level=DEBUG msg="push/pull successful" interval=5s500beta # [27660.204497] beta data-mesher[208]: time=2026-09-04T15:08:00.190Z level=INFO msg="scheduling file download" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg501beta # [27660.204553] beta data-mesher[208]: time=2026-09-04T15:08:00.190Z level=INFO msg="downloading file" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg signed_at="2026-09-04 15:07:55.885 +0000 UTC" signed_by="LnPZqh0TaOUOyJXt/o8dVINFYPHYNlkyLz+6Uki2jjg=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs502beta # [27660.208125] beta data-mesher[208]: time=2026-09-04T15:08:00.193Z level=INFO msg="download complete" name=test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg signed_at="2026-09-04 15:07:55.885 +0000 UTC" signed_by="LnPZqh0TaOUOyJXt/o8dVINFYPHYNlkyLz+6Uki2jjg=" peer=12D3KooWCwhP5UbPZQMn331CRDTPr7tYXLivbr3aZBYe6vXsEArs written=true elapsed=3.60285ms503beta: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg, in 5.05 seconds)504gamma: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg505gamma: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg && grep -q 'namespace_data' /var/lib/data-mesher/files/home/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg, in 0.01 seconds)506alpha: must succeed: echo -n 'no_cert' > /tmp/ns_nocert507alpha: (finished: must succeed: echo -n 'no_cert' > /tmp/ns_nocert, in 0.01 seconds)508alpha: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub509Error: failed to update file: 403 Forbidden, signer LnPZqh0TaOUOyJXt/o8dVINFYPHYNlkyLz+6Uki2jjg= is not authorized for this file test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg510alpha: (finished: must fail: data-mesher file update /tmp/ns_nocert --name 'test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg' --url http://[::1]:7331 --key /run/secrets/per-machine/alpha/data-mesher-node-identity/identity.key --network-id /nix/store/973sdw0p1q5z7658dvajzb2fgvpb1zs2-shared-data-mesher-network_network.pub, in 0.02 seconds)511(finished: run the VM test script, in 28.09 seconds)512alpha # [27661.013021] alpha data-mesher[211]: time=2026-09-04T15:08:00.998Z level=INFO msg=http_request uri=/files/test_ns/LnPZqh0TaOUOyJXt_o8dVINFYPHYNlkyLz-6Uki2jjg status=403513test script finished in 29.50s514cleanup515kill NspawnMachine (pid 53)516kill NspawnMachine (pid 54)517Container alpha terminated by signal KILL.518kill NspawnMachine (pid 55)519Container beta terminated by signal KILL.520Container gamma terminated by signal KILL.521(finished: cleanup, in 0.59 seconds)